builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1452915225.37 results: success (0) buildid: 20160115143008 builduid: 1c8d2696571e45ebbd2a876bb87905d5 revision: 3a496a28e22f85f155023a787e2db90e040a232b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.373116) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.373743) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.374036) ========= 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=f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006374 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.397782) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.398136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.411562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.411994) ========= 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=f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.461820) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.462163) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.462568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.462873) ========= 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=f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 19:33:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-01-15 19:33:46 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.650844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.651199) ========= 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=f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018752 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.707830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:45.708184) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3a496a28e22f85f155023a787e2db90e040a232b --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 3a496a28e22f85f155023a787e2db90e040a232b --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=f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 19:33:46,190 truncating revision to first 12 chars 2016-01-15 19:33:46,190 Setting DEBUG logging. 2016-01-15 19:33:46,190 attempt 1/10 2016-01-15 19:33:46,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3a496a28e22f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 19:33:46,439 unpacking tar archive at: fx-team-3a496a28e22f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549583 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:46.270946) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:46.271269) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004751 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:46.320524) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:46.320883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:46.330629) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:46.330971) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 19:33:46.331439) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-15 19:33:46.331854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:33:46 INFO - MultiFileLogger online at 20160115 19:33:46 in /builds/slave/test-pgo 19:33:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:33:46 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:33:46 INFO - {'append_to_log': False, 19:33:46 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:33:46 INFO - 'blob_upload_branch': 'Fx-Team', 19:33:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:33:46 INFO - 'branch': 'Fx-Team', 19:33:46 INFO - 'buildbot_json_path': 'buildprops.json', 19:33:46 INFO - 'config_files': ('talos/linux_config.py',), 19:33:46 INFO - 'default_actions': ('clobber', 19:33:46 INFO - 'read-buildbot-config', 19:33:46 INFO - 'download-and-extract', 19:33:46 INFO - 'populate-webroot', 19:33:46 INFO - 'create-virtualenv', 19:33:46 INFO - 'install', 19:33:46 INFO - 'run-tests'), 19:33:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:33:46 INFO - 'download_minidump_stackwalk': True, 19:33:46 INFO - 'download_symbols': 'ondemand', 19:33:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:33:46 INFO - 'tooltool.py': '/tools/tooltool.py', 19:33:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:33:46 INFO - '/tools/misc-python/virtualenv.py')}, 19:33:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:33:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:33:46 INFO - 'installer_path': 'installer.exe', 19:33:46 INFO - 'log_level': 'info', 19:33:46 INFO - 'log_name': 'talos', 19:33:46 INFO - 'log_to_console': True, 19:33:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:33:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:33:46 INFO - 'opt_config_files': (), 19:33:46 INFO - 'pip_index': False, 19:33:46 INFO - 'sps_profile': False, 19:33:46 INFO - 'sps_profile_interval': 0, 19:33:46 INFO - 'suite': 'dromaeojs', 19:33:46 INFO - 'system_bits': '32', 19:33:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:33:46 INFO - 'title': 'talos-linux64-ix-034', 19:33:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:33:46 INFO - 'use_talos_json': True, 19:33:46 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:33:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:33:46 INFO - 'work_dir': 'build'} 19:33:46 INFO - ##### 19:33:46 INFO - ##### Running clobber step. 19:33:46 INFO - ##### 19:33:46 INFO - Running pre-action listener: _resource_record_pre_action 19:33:46 INFO - Running main action method: clobber 19:33:46 INFO - rmtree: /builds/slave/test-pgo/build 19:33:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:33:47 INFO - Running post-action listener: _resource_record_post_action 19:33:47 INFO - ##### 19:33:47 INFO - ##### Running read-buildbot-config step. 19:33:47 INFO - ##### 19:33:47 INFO - Running pre-action listener: _resource_record_pre_action 19:33:47 INFO - Running main action method: read_buildbot_config 19:33:47 INFO - Using buildbot properties: 19:33:47 INFO - { 19:33:47 INFO - "project": "", 19:33:47 INFO - "product": "firefox", 19:33:47 INFO - "script_repo_revision": "production", 19:33:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:33:47 INFO - "repository": "", 19:33:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:33:47 INFO - "buildid": "20160115143008", 19:33:47 INFO - "pgo_build": "True", 19:33:47 INFO - "basedir": "/builds/slave/test-pgo", 19:33:47 INFO - "buildnumber": 585, 19:33:47 INFO - "slavename": "talos-linux64-ix-034", 19:33:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:33:47 INFO - "platform": "ubuntu64_hw", 19:33:47 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:33:47 INFO - "branch": "fx-team", 19:33:47 INFO - "repo_path": "integration/fx-team", 19:33:47 INFO - "revision": "3a496a28e22f85f155023a787e2db90e040a232b", 19:33:47 INFO - "stage_platform": "linux64-pgo", 19:33:47 INFO - "builduid": "1c8d2696571e45ebbd2a876bb87905d5", 19:33:47 INFO - "slavebuilddir": "test" 19:33:47 INFO - } 19:33:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:33:47 INFO - Running post-action listener: _resource_record_post_action 19:33:47 INFO - ##### 19:33:47 INFO - ##### Running download-and-extract step. 19:33:47 INFO - ##### 19:33:47 INFO - Running pre-action listener: _resource_record_pre_action 19:33:47 INFO - Running main action method: download_and_extract 19:33:47 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:47 INFO - https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:33:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/test_packages.json 19:33:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/test_packages.json 19:33:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:33:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:33:49 INFO - Downloaded 1448 bytes. 19:33:49 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:33:49 INFO - Using the following test package requirements: 19:33:49 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:33:49 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:33:49 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:33:49 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:49 INFO - u'jsshell-linux-x86_64.zip'], 19:33:49 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:33:49 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:33:49 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:33:49 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:33:49 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:33:49 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:33:49 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:33:49 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:49 INFO - https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:33:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:33:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:33:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/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 19:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/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 19:33:54 INFO - Downloaded 22441173 bytes. 19:33:54 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'] 19:33:54 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 19:33:55 INFO - Return code: 0 19:33:55 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 19:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:55 INFO - https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:33:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:33:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:33:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/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 19:33:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/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 19:33:58 INFO - Downloaded 22441173 bytes. 19:33:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:33:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:33:59 INFO - Return code: 0 19:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:59 INFO - https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:33:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:33:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:33:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/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 19:33:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/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 19:34:03 INFO - Downloaded 11132144 bytes. 19:34:03 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'] 19:34:03 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 19:34:04 INFO - Return code: 0 19:34: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')]} 19:34:04 INFO - https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:34:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:34:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:34:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/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 19:34:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NXLlltBtTqyYz2kG9x6gDQ/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 19:34:06 INFO - Downloaded 55894001 bytes. 19:34:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:34:06 INFO - mkdir: /builds/slave/test-pgo/properties 19:34:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:34:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:34:06 INFO - Contents: 19:34:06 INFO - build_url:https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:34:06 INFO - Running post-action listener: _resource_record_post_action 19:34:06 INFO - Running post-action listener: set_extra_try_arguments 19:34:06 INFO - ##### 19:34:06 INFO - ##### Running populate-webroot step. 19:34:06 INFO - ##### 19:34:06 INFO - Running pre-action listener: _resource_record_pre_action 19:34:06 INFO - Running main action method: populate_webroot 19:34:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:34:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:34:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:34:06 INFO - '--tppagecycles', 19:34:06 INFO - '7'], 19:34:06 INFO - 'tests': ['tsvgm']}}, 19:34:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:34:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:34:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:34:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:34:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:34:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:34:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:34:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:06 INFO - 'talos_options': ['--e10s'], 19:34:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:34:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:06 INFO - 'tests': ['damp', 'tps']}, 19:34:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:06 INFO - 'talos_options': ['--e10s'], 19:34:06 INFO - 'tests': ['damp', 'tps']}, 19:34:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:34:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:34:06 INFO - 'other': {'tests': ['a11yr', 19:34:06 INFO - 'ts_paint', 19:34:06 INFO - 'tpaint', 19:34:06 INFO - 'sessionrestore', 19:34:06 INFO - 'sessionrestore_no_auto_restore']}, 19:34:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:34:06 INFO - 'tests': ['a11yr', 19:34:06 INFO - 'ts_paint', 19:34:06 INFO - 'tpaint', 19:34:06 INFO - 'sessionrestore', 19:34:06 INFO - 'sessionrestore_no_auto_restore']}, 19:34:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:34:06 INFO - 'tests': ['a11yr', 19:34:06 INFO - 'ts_paint', 19:34:06 INFO - 'tpaint', 19:34:06 INFO - 'sessionrestore', 19:34:06 INFO - 'sessionrestore_no_auto_restore']}, 19:34:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:34:06 INFO - 'tests': ['a11yr', 19:34:06 INFO - 'ts_paint', 19:34:06 INFO - 'tpaint', 19:34:06 INFO - 'sessionrestore', 19:34:06 INFO - 'sessionrestore_no_auto_restore']}, 19:34:06 INFO - 'other_l64': {'tests': ['a11yr', 19:34:06 INFO - 'ts_paint', 19:34:06 INFO - 'tpaint', 19:34:06 INFO - 'sessionrestore', 19:34:06 INFO - 'sessionrestore_no_auto_restore']}, 19:34:06 INFO - 'other_nol64': {'tests': ['a11yr', 19:34:06 INFO - 'ts_paint', 19:34:06 INFO - 'tpaint', 19:34:06 INFO - 'sessionrestore', 19:34:06 INFO - 'sessionrestore_no_auto_restore']}, 19:34:06 INFO - 'svgr': {'tests': ['tsvgx', 19:34:06 INFO - 'tsvgr_opacity', 19:34:06 INFO - 'tart', 19:34:06 INFO - 'tscrollx', 19:34:06 INFO - 'cart']}, 19:34:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:34:06 INFO - 'tests': ['tsvgx', 19:34:06 INFO - 'tsvgr_opacity', 19:34:06 INFO - 'tart', 19:34:06 INFO - 'tscrollx', 19:34:06 INFO - 'cart']}, 19:34:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:06 INFO - 'tests': ['tp5o']}, 19:34:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:06 INFO - 'talos_options': ['--e10s'], 19:34:06 INFO - 'tests': ['tp5o']}, 19:34:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:06 INFO - 'talos_options': ['--xperf_path', 19:34:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:34:06 INFO - 'tests': ['tp5n']}, 19:34:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:06 INFO - 'talos_options': ['--e10s', 19:34:06 INFO - '--xperf_path', 19:34:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:34:06 INFO - 'tests': ['tp5n']}}, 19:34:06 INFO - 'talos.zip': {'path': '', 19:34:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:34:06 INFO - Running post-action listener: _resource_record_post_action 19:34:06 INFO - ##### 19:34:06 INFO - ##### Running create-virtualenv step. 19:34:06 INFO - ##### 19:34:06 INFO - Running pre-action listener: _resource_record_pre_action 19:34:06 INFO - Running main action method: create_virtualenv 19:34:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:34:06 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 19:34:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:34:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:34:06 INFO - Using real prefix '/usr' 19:34:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:34:07 INFO - Installing distribute.............................................................................................................................................................................................done. 19:34:09 INFO - Installing pip.................done. 19:34:09 INFO - Return code: 0 19:34:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d8c4d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e840>, '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 0x1a0b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0bb60>, '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': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', '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 19:34:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:34:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:34:09 INFO - Using env: {'DISPLAY': ':0', 19:34:09 INFO - 'HOME': '/home/cltbld', 19:34:09 INFO - 'LANG': 'en_US.UTF-8', 19:34:09 INFO - 'LANGUAGE': 'en_US:en', 19:34:09 INFO - 'LOGNAME': 'cltbld', 19:34:09 INFO - 'MAIL': '/var/mail/cltbld', 19:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:09 INFO - 'MOZ_NO_REMOTE': '1', 19:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:09 INFO - 'NO_EM_RESTART': '1', 19:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:34:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:34:09 INFO - 'SHELL': '/bin/bash', 19:34:09 INFO - 'SHLVL': '1', 19:34:09 INFO - 'TERM': 'linux', 19:34:09 INFO - 'TMOUT': '86400', 19:34:09 INFO - 'USER': 'cltbld', 19:34:09 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', 19:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:09 INFO - '_': '/tools/buildbot/bin/python'} 19:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:09 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 19:34:09 INFO - Cleaning up... 19:34:09 INFO - Return code: 0 19:34:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d8c4d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e840>, '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 0x1a0b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0bb60>, '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': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', '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 19:34:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:34:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:34:09 INFO - Using env: {'DISPLAY': ':0', 19:34:09 INFO - 'HOME': '/home/cltbld', 19:34:09 INFO - 'LANG': 'en_US.UTF-8', 19:34:09 INFO - 'LANGUAGE': 'en_US:en', 19:34:09 INFO - 'LOGNAME': 'cltbld', 19:34:09 INFO - 'MAIL': '/var/mail/cltbld', 19:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:09 INFO - 'MOZ_NO_REMOTE': '1', 19:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:09 INFO - 'NO_EM_RESTART': '1', 19:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:34:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:34:09 INFO - 'SHELL': '/bin/bash', 19:34:09 INFO - 'SHLVL': '1', 19:34:09 INFO - 'TERM': 'linux', 19:34:09 INFO - 'TMOUT': '86400', 19:34:09 INFO - 'USER': 'cltbld', 19:34:09 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', 19:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:09 INFO - '_': '/tools/buildbot/bin/python'} 19:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:09 INFO - Downloading/unpacking psutil>=0.7.1 19:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:11 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:34:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:34:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:34:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:34:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:34:11 INFO - Installing collected packages: psutil 19:34:11 INFO - Running setup.py install for psutil 19:34:11 INFO - building 'psutil._psutil_linux' extension 19:34:11 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 19:34:11 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 19:34:11 INFO - building 'psutil._psutil_posix' extension 19:34:11 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 19:34:12 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 19:34:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:34:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:34:12 INFO - Successfully installed psutil 19:34:12 INFO - Cleaning up... 19:34:12 INFO - Return code: 0 19:34:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d8c4d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e840>, '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 0x1a0b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0bb60>, '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': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', '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 19:34:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:34:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:34:12 INFO - Using env: {'DISPLAY': ':0', 19:34:12 INFO - 'HOME': '/home/cltbld', 19:34:12 INFO - 'LANG': 'en_US.UTF-8', 19:34:12 INFO - 'LANGUAGE': 'en_US:en', 19:34:12 INFO - 'LOGNAME': 'cltbld', 19:34:12 INFO - 'MAIL': '/var/mail/cltbld', 19:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:12 INFO - 'MOZ_NO_REMOTE': '1', 19:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:12 INFO - 'NO_EM_RESTART': '1', 19:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:34:12 INFO - 'PWD': '/builds/slave/test-pgo', 19:34:12 INFO - 'SHELL': '/bin/bash', 19:34:12 INFO - 'SHLVL': '1', 19:34:12 INFO - 'TERM': 'linux', 19:34:12 INFO - 'TMOUT': '86400', 19:34:12 INFO - 'USER': 'cltbld', 19:34:12 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', 19:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:12 INFO - '_': '/tools/buildbot/bin/python'} 19:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:34:12 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 19:34:12 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 19:34:12 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 19:34:12 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 19:34:12 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 19:34:12 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 19:34:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:34:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:34:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:34:14 INFO - Installing collected packages: mozsystemmonitor 19:34:14 INFO - Running setup.py install for mozsystemmonitor 19:34:14 INFO - Successfully installed mozsystemmonitor 19:34:14 INFO - Cleaning up... 19:34:14 INFO - Return code: 0 19:34:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:34:14 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')]} 19:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:14 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')]} 19:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d8c4d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e840>, '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 0x1a0b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0bb60>, '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': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', '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 19:34:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:34:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:34:14 INFO - Using env: {'DISPLAY': ':0', 19:34:14 INFO - 'HOME': '/home/cltbld', 19:34:14 INFO - 'LANG': 'en_US.UTF-8', 19:34:14 INFO - 'LANGUAGE': 'en_US:en', 19:34:14 INFO - 'LOGNAME': 'cltbld', 19:34:14 INFO - 'MAIL': '/var/mail/cltbld', 19:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:14 INFO - 'MOZ_NO_REMOTE': '1', 19:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:14 INFO - 'NO_EM_RESTART': '1', 19:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:34:14 INFO - 'PWD': '/builds/slave/test-pgo', 19:34:14 INFO - 'SHELL': '/bin/bash', 19:34:14 INFO - 'SHLVL': '1', 19:34:14 INFO - 'TERM': 'linux', 19:34:14 INFO - 'TMOUT': '86400', 19:34:14 INFO - 'USER': 'cltbld', 19:34:14 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', 19:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:14 INFO - '_': '/tools/buildbot/bin/python'} 19:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:14 INFO - Downloading/unpacking blobuploader==1.2.4 19:34:14 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 19:34:14 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 19:34:14 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 19:34:14 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 19:34:14 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 19:34:14 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 19:34:16 INFO - Downloading blobuploader-1.2.4.tar.gz 19:34:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:34:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:34:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:34:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:34:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:16 INFO - Downloading docopt-0.6.1.tar.gz 19:34:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:34:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:34:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:34:16 INFO - Running setup.py install for blobuploader 19:34:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:34:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:34:17 INFO - Running setup.py install for requests 19:34:17 INFO - Running setup.py install for docopt 19:34:17 INFO - Successfully installed blobuploader requests docopt 19:34:17 INFO - Cleaning up... 19:34:17 INFO - Return code: 0 19:34:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d8c4d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e840>, '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 0x1a0b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0bb60>, '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': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', '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 19:34:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:34:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:34:17 INFO - Using env: {'DISPLAY': ':0', 19:34:17 INFO - 'HOME': '/home/cltbld', 19:34:17 INFO - 'LANG': 'en_US.UTF-8', 19:34:17 INFO - 'LANGUAGE': 'en_US:en', 19:34:17 INFO - 'LOGNAME': 'cltbld', 19:34:17 INFO - 'MAIL': '/var/mail/cltbld', 19:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:17 INFO - 'MOZ_NO_REMOTE': '1', 19:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:17 INFO - 'NO_EM_RESTART': '1', 19:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:34:17 INFO - 'PWD': '/builds/slave/test-pgo', 19:34:17 INFO - 'SHELL': '/bin/bash', 19:34:17 INFO - 'SHLVL': '1', 19:34:17 INFO - 'TERM': 'linux', 19:34:17 INFO - 'TMOUT': '86400', 19:34:17 INFO - 'USER': 'cltbld', 19:34:17 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', 19:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:17 INFO - '_': '/tools/buildbot/bin/python'} 19:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:34:17 INFO - Running setup.py (path:/tmp/pip-xiOFFw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:34:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:34:17 INFO - Running setup.py (path:/tmp/pip-D2Ln9R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:34:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:34:17 INFO - Running setup.py (path:/tmp/pip-y_SgBE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:34:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:34:17 INFO - Running setup.py (path:/tmp/pip-5o3N4Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:34:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:34:17 INFO - Running setup.py (path:/tmp/pip-weu7J9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:34:18 INFO - Running setup.py (path:/tmp/pip-KZ8rQf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:34:18 INFO - Running setup.py (path:/tmp/pip-GHmmle-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:34:18 INFO - Running setup.py (path:/tmp/pip-F11TyS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:34:18 INFO - Running setup.py (path:/tmp/pip-2OzSQj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:34:18 INFO - Running setup.py (path:/tmp/pip-qCAG2j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:34:18 INFO - Running setup.py (path:/tmp/pip-kKLpFY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:34:18 INFO - Running setup.py (path:/tmp/pip-3NiQkT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:34:18 INFO - Running setup.py (path:/tmp/pip-HwWILi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:34:18 INFO - Running setup.py (path:/tmp/pip-5fYgh1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:34:18 INFO - Running setup.py (path:/tmp/pip-_tHMMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:34:18 INFO - Running setup.py (path:/tmp/pip-QUA3Ob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:34:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:34:18 INFO - Running setup.py (path:/tmp/pip-PC6DY6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:34:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:34:18 INFO - Running setup.py install for manifestparser 19:34:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:34:19 INFO - Running setup.py install for mozcrash 19:34:19 INFO - Running setup.py install for mozdebug 19:34:19 INFO - Running setup.py install for mozdevice 19:34:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:34:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:34:19 INFO - Running setup.py install for mozfile 19:34:19 INFO - Running setup.py install for mozhttpd 19:34:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:34:19 INFO - Running setup.py install for mozinfo 19:34:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:34:19 INFO - Running setup.py install for mozInstall 19:34:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:34:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:34:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:34:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:34:19 INFO - Running setup.py install for mozleak 19:34:19 INFO - Running setup.py install for mozlog 19:34:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:34:19 INFO - Running setup.py install for moznetwork 19:34:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:34:20 INFO - Running setup.py install for mozprocess 19:34:20 INFO - Running setup.py install for mozprofile 19:34:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:34:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:34:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:34:20 INFO - Running setup.py install for mozrunner 19:34:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:34:20 INFO - Running setup.py install for mozscreenshot 19:34:20 INFO - Running setup.py install for moztest 19:34:20 INFO - Running setup.py install for mozversion 19:34:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:34:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:34:20 INFO - Cleaning up... 19:34:20 INFO - Return code: 0 19:34:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d8c4d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e840>, '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 0x1a0b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0bb60>, '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': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', '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 19:34:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:34:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:34:20 INFO - Using env: {'DISPLAY': ':0', 19:34:20 INFO - 'HOME': '/home/cltbld', 19:34:20 INFO - 'LANG': 'en_US.UTF-8', 19:34:20 INFO - 'LANGUAGE': 'en_US:en', 19:34:20 INFO - 'LOGNAME': 'cltbld', 19:34:20 INFO - 'MAIL': '/var/mail/cltbld', 19:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:20 INFO - 'MOZ_NO_REMOTE': '1', 19:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:20 INFO - 'NO_EM_RESTART': '1', 19:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:34:20 INFO - 'PWD': '/builds/slave/test-pgo', 19:34:20 INFO - 'SHELL': '/bin/bash', 19:34:20 INFO - 'SHLVL': '1', 19:34:20 INFO - 'TERM': 'linux', 19:34:20 INFO - 'TMOUT': '86400', 19:34:20 INFO - 'USER': 'cltbld', 19:34:20 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', 19:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:20 INFO - '_': '/tools/buildbot/bin/python'} 19:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:34:20 INFO - Running setup.py (path:/tmp/pip-ESUp1j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:34:20 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)) 19:34:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:34:20 INFO - Running setup.py (path:/tmp/pip-wgJuFI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:34:21 INFO - Running setup.py (path:/tmp/pip-j3uRzW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:34:21 INFO - Running setup.py (path:/tmp/pip-5ZUjvP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:34:21 INFO - Running setup.py (path:/tmp/pip-5PFzkN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:34:21 INFO - Running setup.py (path:/tmp/pip-3NbG58-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:34:21 INFO - Running setup.py (path:/tmp/pip-3wikRY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:34:21 INFO - Running setup.py (path:/tmp/pip-fPsUkj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:34:21 INFO - Running setup.py (path:/tmp/pip-dYrBwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:34:21 INFO - Running setup.py (path:/tmp/pip-oaK8iN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:34:21 INFO - Running setup.py (path:/tmp/pip-C5IqGL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:34:21 INFO - Running setup.py (path:/tmp/pip-CQcrbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:34:21 INFO - Running setup.py (path:/tmp/pip-sJcDm4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:34:21 INFO - Running setup.py (path:/tmp/pip-1EQJAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:34:21 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)) 19:34:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:34:21 INFO - Running setup.py (path:/tmp/pip-_KfE7f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:34:22 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)) 19:34:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:34:22 INFO - Running setup.py (path:/tmp/pip-l6IB2f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:34:22 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)) 19:34:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:34:22 INFO - Running setup.py (path:/tmp/pip-qimY2i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:34:22 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)) 19:34:22 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)) 19:34:22 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)) 19:34:22 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)) 19:34:22 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)) 19:34:22 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)) 19:34:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:23 INFO - Downloading blessings-1.5.1.tar.gz 19:34:23 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:34:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:34:23 INFO - Installing collected packages: blessings 19:34:23 INFO - Running setup.py install for blessings 19:34:24 INFO - Successfully installed blessings 19:34:24 INFO - Cleaning up... 19:34:24 INFO - Return code: 0 19:34:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:34:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:34:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:34:24 INFO - Reading from file tmpfile_stdout 19:34:24 INFO - Current package versions: 19:34:24 INFO - argparse == 1.2.1 19:34:24 INFO - blessings == 1.5.1 19:34:24 INFO - blobuploader == 1.2.4 19:34:24 INFO - docopt == 0.6.1 19:34:24 INFO - manifestparser == 1.1 19:34:24 INFO - mozInstall == 1.12 19:34:24 INFO - mozcrash == 0.16 19:34:24 INFO - mozdebug == 0.1 19:34:24 INFO - mozdevice == 0.48 19:34:24 INFO - mozfile == 1.2 19:34:24 INFO - mozhttpd == 0.7 19:34:24 INFO - mozinfo == 0.9 19:34:24 INFO - mozleak == 0.1 19:34:24 INFO - mozlog == 3.1 19:34:24 INFO - moznetwork == 0.27 19:34:24 INFO - mozprocess == 0.22 19:34:24 INFO - mozprofile == 0.28 19:34:24 INFO - mozrunner == 6.11 19:34:24 INFO - mozscreenshot == 0.1 19:34:24 INFO - mozsystemmonitor == 0.0 19:34:24 INFO - moztest == 0.7 19:34:24 INFO - mozversion == 1.4 19:34:24 INFO - psutil == 3.1.1 19:34:24 INFO - requests == 1.2.3 19:34:24 INFO - wsgiref == 0.1.2 19:34:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:34:24 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')]} 19:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:24 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')]} 19:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d8c4d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e840>, '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 0x1a0b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0bb60>, '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': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', '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 19:34:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:34:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:34:24 INFO - Using env: {'DISPLAY': ':0', 19:34:24 INFO - 'HOME': '/home/cltbld', 19:34:24 INFO - 'LANG': 'en_US.UTF-8', 19:34:24 INFO - 'LANGUAGE': 'en_US:en', 19:34:24 INFO - 'LOGNAME': 'cltbld', 19:34:24 INFO - 'MAIL': '/var/mail/cltbld', 19:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:24 INFO - 'MOZ_NO_REMOTE': '1', 19:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:24 INFO - 'NO_EM_RESTART': '1', 19:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:34:24 INFO - 'PWD': '/builds/slave/test-pgo', 19:34:24 INFO - 'SHELL': '/bin/bash', 19:34:24 INFO - 'SHLVL': '1', 19:34:24 INFO - 'TERM': 'linux', 19:34:24 INFO - 'TMOUT': '86400', 19:34:24 INFO - 'USER': 'cltbld', 19:34:24 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', 19:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:24 INFO - '_': '/tools/buildbot/bin/python'} 19:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:24 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)) 19:34:24 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)) 19:34:24 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)) 19:34:24 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)) 19:34:24 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)) 19:34:24 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)) 19:34:24 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)) 19:34:24 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)) 19:34:24 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)) 19:34:24 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)) 19:34:24 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)) 19:34:24 INFO - Cleaning up... 19:34:24 INFO - Return code: 0 19:34:24 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:34:24 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')]} 19:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:24 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')]} 19:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d8c4d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e840>, '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 0x1a0b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0bb60>, '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': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', '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 19:34:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:34:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:34:24 INFO - Using env: {'DISPLAY': ':0', 19:34:24 INFO - 'HOME': '/home/cltbld', 19:34:24 INFO - 'LANG': 'en_US.UTF-8', 19:34:24 INFO - 'LANGUAGE': 'en_US:en', 19:34:24 INFO - 'LOGNAME': 'cltbld', 19:34:24 INFO - 'MAIL': '/var/mail/cltbld', 19:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:24 INFO - 'MOZ_NO_REMOTE': '1', 19:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:24 INFO - 'NO_EM_RESTART': '1', 19:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:34:24 INFO - 'PWD': '/builds/slave/test-pgo', 19:34:24 INFO - 'SHELL': '/bin/bash', 19:34:24 INFO - 'SHLVL': '1', 19:34:24 INFO - 'TERM': 'linux', 19:34:24 INFO - 'TMOUT': '86400', 19:34:24 INFO - 'USER': 'cltbld', 19:34:24 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', 19:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:24 INFO - '_': '/tools/buildbot/bin/python'} 19:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:24 INFO - Downloading/unpacking jsonschema 19:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:34:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:34:26 INFO - Downloading/unpacking functools32 (from jsonschema) 19:34:26 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 19:34:26 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 19:34:26 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 19:34:26 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 19:34:26 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 19:34:26 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 19:34:26 INFO - Downloading functools32-3.2.3-2.tar.gz 19:34:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:34:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:34:26 INFO - warning: no files found matching '*.txt' 19:34:26 INFO - no previously-included directories found matching 'build' 19:34:26 INFO - no previously-included directories found matching 'dist' 19:34:26 INFO - no previously-included directories found matching '.git*' 19:34:26 INFO - Installing collected packages: jsonschema, functools32 19:34:26 INFO - Running setup.py install for functools32 19:34:26 INFO - warning: no files found matching '*.txt' 19:34:26 INFO - no previously-included directories found matching 'build' 19:34:26 INFO - no previously-included directories found matching 'dist' 19:34:26 INFO - no previously-included directories found matching '.git*' 19:34:26 INFO - Successfully installed jsonschema functools32 19:34:26 INFO - Cleaning up... 19:34:26 INFO - Return code: 0 19:34:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:34: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')]} 19:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34: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')]} 19:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d8c4d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e840>, '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 0x1a0b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0bb60>, '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': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', '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 19:34:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:34:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:34:26 INFO - Using env: {'DISPLAY': ':0', 19:34:26 INFO - 'HOME': '/home/cltbld', 19:34:26 INFO - 'LANG': 'en_US.UTF-8', 19:34:26 INFO - 'LANGUAGE': 'en_US:en', 19:34:26 INFO - 'LOGNAME': 'cltbld', 19:34:26 INFO - 'MAIL': '/var/mail/cltbld', 19:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:26 INFO - 'MOZ_NO_REMOTE': '1', 19:34:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:26 INFO - 'NO_EM_RESTART': '1', 19:34:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:34:26 INFO - 'PWD': '/builds/slave/test-pgo', 19:34:26 INFO - 'SHELL': '/bin/bash', 19:34:26 INFO - 'SHLVL': '1', 19:34:26 INFO - 'TERM': 'linux', 19:34:26 INFO - 'TMOUT': '86400', 19:34:26 INFO - 'USER': 'cltbld', 19:34:26 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', 19:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:26 INFO - '_': '/tools/buildbot/bin/python'} 19:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:27 INFO - Downloading/unpacking flake8 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:34:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:34:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:34:28 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 19:34:28 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 19:34:28 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 19:34:28 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 19:34:28 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 19:34:28 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 19:34:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:34:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:34:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:34:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:34:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:34:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:34:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:34:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:34:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:34:29 INFO - no previously-included directories found matching 'docs/_build' 19:34:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:34:29 INFO - Running setup.py install for pep8 19:34:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:34:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:34:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:34:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:34:29 INFO - no previously-included directories found matching 'docs/_build' 19:34:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:34:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:34:29 INFO - Cleaning up... 19:34:29 INFO - Return code: 0 19:34:29 INFO - Running post-action listener: _resource_record_post_action 19:34:29 INFO - Running post-action listener: _start_resource_monitoring 19:34:29 INFO - Starting resource monitoring. 19:34:29 INFO - ##### 19:34:29 INFO - ##### Running install step. 19:34:29 INFO - ##### 19:34:29 INFO - Running pre-action listener: _resource_record_pre_action 19:34:29 INFO - Running main action method: install 19:34:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:34:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:34:29 INFO - Reading from file tmpfile_stdout 19:34:29 INFO - Detecting whether we're running mozinstall >=1.0... 19:34:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:34:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:34:30 INFO - Reading from file tmpfile_stdout 19:34:30 INFO - Output received: 19:34:30 INFO - Usage: mozinstall [options] installer 19:34:30 INFO - Options: 19:34:30 INFO - -h, --help show this help message and exit 19:34:30 INFO - -d DEST, --destination=DEST 19:34:30 INFO - Directory to install application into. [default: 19:34:30 INFO - "/builds/slave/test-pgo"] 19:34:30 INFO - --app=APP Application being installed. [default: firefox] 19:34:30 INFO - mkdir: /builds/slave/test-pgo/build/application 19:34:30 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'] 19:34:30 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 19:34:46 INFO - Reading from file tmpfile_stdout 19:34:46 INFO - Output received: 19:34:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:34:46 INFO - Running post-action listener: _resource_record_post_action 19:34:46 INFO - ##### 19:34:46 INFO - ##### Running run-tests step. 19:34:46 INFO - ##### 19:34:46 INFO - Running pre-action listener: _resource_record_pre_action 19:34:46 INFO - Running main action method: run_tests 19:34:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:34:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:34:46 INFO - Python 2.7.3 19:34:46 INFO - Return code: 0 19:34:46 INFO - grabbing minidump binary from tooltool 19:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:46 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 0x1a9e840>, '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 0x1a0b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:34:46 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 19:34:46 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 19:34:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:34:46 INFO - Return code: 0 19:34:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:34:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:34:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:34:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:34:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:34:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:34:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:34:47 INFO - Return code: 0 19:34:47 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 19:34:47 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 19:34:47 INFO - Using env: {'DISPLAY': ':0', 19:34:47 INFO - 'HOME': '/home/cltbld', 19:34:47 INFO - 'LANG': 'en_US.UTF-8', 19:34:47 INFO - 'LANGUAGE': 'en_US:en', 19:34:47 INFO - 'LOGNAME': 'cltbld', 19:34:47 INFO - 'MAIL': '/var/mail/cltbld', 19:34:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:34:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:47 INFO - 'MOZ_NO_REMOTE': '1', 19:34:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:47 INFO - 'NO_EM_RESTART': '1', 19:34:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:34:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:34:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:34:47 INFO - 'SHELL': '/bin/bash', 19:34:47 INFO - 'SHLVL': '1', 19:34:47 INFO - 'TERM': 'linux', 19:34:47 INFO - 'TMOUT': '86400', 19:34:47 INFO - 'USER': 'cltbld', 19:34:47 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519', 19:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:47 INFO - '_': '/tools/buildbot/bin/python'} 19:34:47 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:34:47 INFO - mozversion application_buildid: 20160115143008 19:34:47 INFO - mozversion application_changeset: 3a496a28e22f85f155023a787e2db90e040a232b 19:34:47 INFO - mozversion application_display_name: Nightly 19:34:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:34:47 INFO - mozversion application_name: Firefox 19:34:47 INFO - mozversion application_remotingname: firefox 19:34:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:34:47 INFO - mozversion application_vendor: Mozilla 19:34:47 INFO - mozversion application_version: 46.0a1 19:34:47 INFO - mozversion platform_buildid: 20160115143008 19:34:47 INFO - mozversion platform_changeset: 3a496a28e22f85f155023a787e2db90e040a232b 19:34:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:34:47 INFO - mozversion platform_version: 46.0a1 19:34:47 INFO - using testdate: 1452915287 19:34:47 INFO - actual date: 1452915287 19:34:47 INFO - starting webserver on 'localhost:60704' 19:34:47 INFO - SUITE-START | Running 3 tests 19:34:47 INFO - TEST-START | dromaeo_css 19:34:47 INFO - operating with platform_type : linux_ 19:34:47 INFO - Initialising browser for dromaeo_css test... 19:34:47 INFO - TEST-INFO | started process 3314 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprXZJn6/profile http://localhost:60704/getInfo.html) 19:34:51 INFO - PROCESS | 3314 | __metrics Screen width/height:1600/1200 19:34:51 INFO - PROCESS | 3314 | colorDepth:24 19:34:51 INFO - PROCESS | 3314 | Browser inner width/height: 1024/697 19:34:51 INFO - PROCESS | 3314 | __metrics 19:34:51 INFO - PROCESS | 3314 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:34:51 INFO - PROCESS | 3314 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:34:52 INFO - TEST-INFO | 3314: exit 0 19:34:52 INFO - Browser initialized. 19:34:52 INFO - Running cycle 1/1 for dromaeo_css test... 19:34:52 INFO - TEST-INFO | started process 3407 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprXZJn6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:35:04 INFO - PROCESS | 3407 | RSS: Main: 150589440 19:35:04 INFO - PROCESS | 3407 | 19:35:55 INFO - PROCESS | 3407 | 1452915355589 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] 19:38:03 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:60704/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60704/tests/dromaeo/cssquery-ext.html) 19:38:04 INFO - PROCESS | 3407 | RSS: Main: 242008064 19:38:04 INFO - PROCESS | 3407 | 19:41:06 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:60704/tests/dromaeo/cssquery-ext.html (next: http://localhost:60704/tests/dromaeo/cssquery-jquery.html) 19:41:07 INFO - PROCESS | 3407 | RSS: Main: 228405248 19:41:07 INFO - PROCESS | 3407 | 19:44:09 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:60704/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60704/tests/dromaeo/cssquery-mootools.html) 19:44:10 INFO - PROCESS | 3407 | RSS: Main: 229593088 19:44:10 INFO - PROCESS | 3407 | 19:47:11 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:60704/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60704/tests/dromaeo/cssquery-prototype.html) 19:47:12 INFO - PROCESS | 3407 | RSS: Main: 207904768 19:47:12 INFO - PROCESS | 3407 | 19:50:15 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:60704/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60704/tests/dromaeo/cssquery-yui.html) 19:50:15 INFO - PROCESS | 3407 | RSS: Main: 212078592 19:50:15 INFO - PROCESS | 3407 | 19:53:18 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:60704/tests/dromaeo/cssquery-yui.html (next: http://localhost:60704/tests/dromaeo/cssquery-dojo.html) 19:53:18 INFO - PROCESS | 3407 | RSS: Main: 296321024 19:53:18 INFO - PROCESS | 3407 | 19:53:18 INFO - PROCESS | 3407 | __start_tp_report 19:53:18 INFO - PROCESS | 3407 | _x_x_mozilla_page_load 19:53:18 INFO - PROCESS | 3407 | _x_x_mozilla_page_load_details 19:53:18 INFO - PROCESS | 3407 | |i|pagename|runs| 19:53:18 INFO - PROCESS | 3407 | |0;dojo.html;3002;3027.6215473065854;3065.1111177758453;3082.4913889208283;3105.6894310568937;4878.121938051149;4973.552380285773;5068.087744206042;5076.340075790146;5104.693718376895;5110.667806592578;5122.564582010534;5125.333706618135;5140.691558506493;5168.22476628506;4603.861884143473;4621.4685311189305;4636.142313671965;4694.859154225379;4703.6472264580125;4727.810887564493;4739.691920025204;4779;4786.617070634358;4804.735739534324;4536.455625324949;4599.747013914233;4605.608523275509;4656.301554766778;4668.509806470306;4621.630269578425;4622.399088118523;4624.09830083134;4633.4439867215815;4652.418447694038;4604.815807367735;4615.446146462413;4622.445306563201;4631.258998560248;4653.488116307203;4811.061842940628;4872.220444728827;4967.50324967504;4976.527229913152;5007.84976450707;5463.125899856004;5470.5350045246205;5478.835634930919;5480.095784195603;5483.341998960111;5277.445868183862;5495.917561236584;5499.697516636584;5503.449655034505;5507.815412141837;5038.874028149289;5189.1697328427645;5225.4774522548205;5251.10731175701;5284.207368894658;5620.634658747168;5625.887482250414;5627.971860140673;5628.97185514078;5633.943660563424;5256.474352564713;5325.893482130413;5431.2396264522995;5448;5449.128139497661;5449.754761035763;5467.972660136754;5485.451454854483;5491.313585801775;5536.141898005815;5421.241026256327;5475.206095116186;5478.863028424242;5478.890422191534;5486.3690675572025;5288.418273989858;5360.115580929181;5452.781888724486;5477.452254774491;5523.061079616475;4233.640140588084;4238.258304796648;4244.766537840386;4279.33670281107;4283.100548884707;3767.03940495172;3794.9430758538642;3801.0877389426337;3814.8664796731982;3830.578636349999;4999.950000500021;5067.543921047123;5083.74581270935;5133;5199.818006369759;5506.394296627368;5514.365847927459;5532;5534.667919924817;5535.418781028015;5144.897102058013;5176.327077479904;5180.7150606717;5182.326297581366;5224.007438586732;4617.145828021827;4683.95316046842;4751.714897106184;4790.952090479121;4822.397200349957;5665.886682266414;5721.599488035881;5721.713914304268;5727.914081288784;5729.28383952006;5211.843644690665;5479.780808767764;5493.611905153853;5499.862503437446;5541.750621221974;5593.133064375028;5689.317281926195;5712.143178523089;5738.340090889601;5768.971155144365;5373.11343628297;5376.542993845567;5382.111951528111;5382.784688612568;5387.084195686664;5233.738313084406;5349.759260833194;5441.238226648352;5443.455654434525;5505.201745746925;5381.946180538144;5404.459554044564;5404.918926216032;5405.783768649368;5450.509454149145;5321.54766844807;5359.678419294854;5373.9731301343245;5383.488568585978;5426.67439953604;5119.104156772624;5196.7401629917595;5268.315119034501;5290.523852853262;5296.443873393238;5426.484483974016;5440.319960004999;5443.673379597237;5461.235427040138;5483.4516548344845;5281.9471805281455;5286.867828304323;5288.603354748332;5292.232626269247;5295.046891559402 19:53:18 INFO - PROCESS | 3407 | |1;ext.html;519.5713536332527;521.7730287325012;532.1087178975217;561.8932402843461;578.0519947286451;28775.568366474494;29233.707662923363;35921.640783592185;36684.81657591715;36734.44898326527;39203.803980980054;39427.21145577087;39581.802090989506;39726.20547589046;39811;8325.250727434544;8526.147385261454;8532.914670853273;8533.615987280587;8538.103499132594;8336.791580210513;8410.36922230835;8478;8478.279346255576;8482.830343393129;8465.153484651517;8553.615087321054;8697.913020869806;8721.12788721129;8725.389222754378;8586.141385861427;8610.784730381727;8622.35332350073;8679.783005424883;8679.913200867974;8492.66029358825;8617.956910215471;8626.56867156646;8629.439086459422;8638.65445382184;39445.60554394448;40154;40228.79885600553;40292.19415611671;40325.19349612991;3376.898693039213;3836.3094642964256;3839.232153569297;3855.248226595815;3952.565217826037;29070.12789616315;29162.125136245948;29230.70769292301;29239.269018274714;30537.847310763525;3380.256343604403;3442.638522955104;3464.20323325634;3474.9826250868837;3673.540807399075;265133;265468;265501;265928;266073.66963165253;58351;58717.41282587205;58863;58951;59005.704971474865;62167.689161553906;62758.68620656867;62881;62893.37106628967;62901.370986290465;13964;13972.441102355791;14064.578062658136;14149.85850141506;14157.221352825694;10826.729331766612;10979.890201098047;11018.283811552223;11060.225784195029;11078;18235.556172966593;19532;19744.11151498186;19858;19887.502812429804;6398.968005160037;7487.3261406473675;7613.276738709814;7887.290143887078;7891.250331218525;901.3150005995491;934.4066517761271;1025.1696126137704;1049.3651340938775;1111.3165403277087;28364.85817570899;28427.28931776722;28836.279093022844;28927.7107228925;29589.55615665767;1074.2802322443981;1096.0135877710125;1107.3687997841153;1117.1286396610656;1146.8623765148236;15122.168280744445;15202.391904323924;15603.708980030355;15823.287952042187;16291.103989280704;400924;406748;445274;449274;489758;53079.734601326745;53635.463645363045;53864;53912;54083.188752168746;1345.8519562848078;1360.843502997168;1362.305224335596;1368.7330970460864;1385.709001109758;25739.485210296065;30456.172629642293;30477.67549251848;30843.228919277197;31049;49113.263301049796;50200.748996254784;50245;50295;50304.245436319216;257557;258385;259035;259107;259237;32927.83536082304;33181;33411.49882751712;33625.327493449506;33640.663593364734;43012.13975720531;43470;43967.12065758603;43984;44001.339979900964;36257;36466;36540.07679385589;37528;37653;35590.64409355873;35993.62803663796;36893.631063690096;36944.076398089186;37074.814625926694;35990.46014309735;35994.46008309825;36320;37868.05329866776;38715.80642096772;29039.564406533496;31195.376092478476;32799.508007380384;33166.170845728084;33198.83400582981;24613.87693061595;24795.50408991774;25074.68631746635;25405.237842864743;25427.87286063558 19:53:18 INFO - PROCESS | 3407 | |2;jquery.html;356.89828398906315;360.7402670077543;365.7677374866959;368.436292472517;371.1611757428211;13567.932160339209;13833.170009799394;15381.230938453074;15927.601809954756;16813.327466901308;14596.124232546055;15264.69470610587;15436.691266174697;15802.367905283774;16407.83592164078;5168.844934651957;5345.812896548621;5347.7058761768085;5348.197770334442;5356.758945847446;3972.56301806801;4094.795260236991;5260.868478288055;5348.277982472356;5498.5876059295515;5627;5631.099024156136;5657.23627310314;5673.546116310706;5689.544836413098;5421.484958928915;5600.943990560083;5605.775768969236;5640.0693885508845;5640.717964101778;4844.176489996674;4974.353334066548;4975.477574854624;4975.7512124394;4977.776000080005;12157.756844863054;13253.668658283523;17820.46538603844;18523.35168269104;18587.721184182246;1887.1413506854349;2066.442060643633;2072.471519762451;2237.641977283643;2316.6177580699164;8780.692675756382;9208.309376796768;9575.186109180728;11363.772724545546;12522.37388130599;1813.3471950097953;1819.8817076890093;1843.714224295223;1852.8610354223351;1885.377825317642;56942.715286423714;57466.85066298692;59049.40950590482;59391;60567.394326056616;8885.511296878734;9150.222231110298;9500.334976551714;9515.04849515043;9520.523973801282;12174.026077913923;12227.1440999131;12228;12267.815982760265;12322.260664360167;6843.931560684429;7050.5769653820935;7058.082449281561;7089.468289878177;7113.288671132948;6682.732690692318;6791;6846.075779769767;6880.208775990725;6963.582185068912;3819.8281077351585;4004.3593025116425;4063.0248740302704;4197.538270790211;4329.15581461612;1655.5281744702943;1765.9823401766075;1775.8756887017785;1798.7571677823587;1834.3488061738158;415.41011763296194;419.5259356926653;874.728834061443;939.8496240601471;1009.9798004039878;8840.602172902234;9828.705138845846;10431.321964072311;10462.947685261677;10734.409607471664;459.16890428324837;467.4670875202272;468.94607120180933;473.60690626780377;475.8834085649038;5801;5948.137520059568;5996.310424301174;6034.63792172471;6101.420365065312;450564;451029;494283;548314;555091;70435;73865;74676;76244;77409.22590774133;461.838356575196;473.2947907617625;487.12074705157534;505.20682528430746;505.21186948360673;9997.650082247086;10037.347572408062;10047.748806279902;10122.089011988955;10312.432816195182;30604.540931885593;31008.534871976488;31106.84446577843;31176.688233118286;31355.372892542477;37567.81216093902;37940.430893537174;39127.02182445462;39395.2120957585;41577;7030.226675065636;7220.38626716735;7459.701611935462;9719.562619682272;9734.610615575297;10922.235443518877;10975.50610222526;11223.831642525533;11351.54593816238;11816.46825892854;6993;7177.2463891292755;7188.460865435009;7293.124825021031;9486.288528360263;7302.56184628924;7364.926350736639;7702.691892324245;7705.345045671181;7755.806104847424;7542.094948605983;7593.8860917087395;7630.542167469969;7633.580153091633;7648.61756912141;9781.510924453607;10006.812429451726;10016.696159883122;10133.189344852246;10289.9485502572;10452.425116618659;10503.474826258504;10604.469776511298;10655.200859935381;10684.57261709523 19:53:18 INFO - PROCESS | 3407 | |3;mootools.html;1308.8102225177342;1372.2452651041924;1408.3310427546915;1530.387844862055;1801.7477553142562;7081.468889833263;7228.313310235526;7679.462437629361;7790;7827;7388.889166662504;7492.175860655324;7495.175530691619;7506.81232969176;7565.583892885889;2016.6672499037716;2255.7631448697857;2280.817534597228;2280.9885950570224;2290.141197051106;2063.484128967758;2288.9198878039274;2349.0721165139844;2352.1532248390567;2353.5292941411785;2318.026428899866;2356.587597170488;2364.4798144408287;2370.7392186859433;2386.296042667417;2296.666983287431;2312.5490529346785;2320.8723520206468;2321.361625552978;2370.7392186859433;2327.138958585317;2343.308723926446;2349.953000939972;2351.4709190432186;2353.5528249632684;8022.598870056532;8055.03339599246;8075.596220188967;8083.595820208966;8102.5543595102245;4935.531124543163;4994.850154495371;4996.925046124311;5036.748162591855;5049.798008079672;3156.210947263184;3169.762267829922;3215.565898603682;3253;3278.278778668689;1010.2170817616333;1039.9168066554657;1066.6906597086913;1078.250615822004;1091.6705536754591;11133;11164.385958772264;11187.384693841836;11198.552057917674;11207.607733729363;4414.757188354672;4431.357453169272;4503.076869241798;4508.301213311942;4527.162474942146;9664.323497355117;9746.512674366253;9752.658656946973;9755.756106097404;9765.072318129767;5088.491150884956;5096.9490305097215;5097.668651537712;5099.770510327045;5100.821471248562;4555.339475775994;4587.4036375271;4595.517470665599;4645.628349732014;4651.511591282867;3531.2231309111953;3608.4226523756074;3756.8121593920196;3837.1174629835295;3888.358420860583;1198.646399312205;1205.1082199172724;1207.1368971185468;1215.7902886627685;1226.4726167747776;1049.1134990932649;1069.572171131538;1074.9247552671238;1218.1229514749366;1337.3714354253486;7443.627818609048;7492.625368731542;7518.398528117737;7542.6605802739;7544.283293087148;1082.875469321038;1098.373926861697;1100.741325788439;1111.216592302441;1113.3653817324048;5943.619218232886;5950.19672344228;6029.698515074228;6033.758649653964;6044.788432404845;9581.760455988657;9942.254330925209;9952.552135153936;10046.19630429564;10055.497225138713;9628.47043412605;9837.213022958145;9960.900390995997;9961.950190249003;9969.152622027064;7586.051743531948;7634.732784352521;7645.961770191114;7651.655675494616;7651.923480765233;7302.744403945836;7333.339999400079;7371.152317483344;7385.556866588022;7422.703091876265;8830.91169088301;8842.91157088421;8954.328425368254;9061.592228349607;9064;8964.32767542424;9071.365004449624;9224.35429519954;9236.307276954121;9258.259339252978;7199;7303.196648368569;7304.123505179413;7306.050213472215;7306.378957788647;6797.796066118024;7192.065031545865;7524.2851929066655;7543.73596924105;7771.4559980800805;7155.856882862209;7164.426845852424;7226.060612120601;7273.890891636735;7298.598577078312;6930.896036559355;7038.120234970629;7076.363127318566;7119.786406407816;7131.893021604784;7243.637818108968;7251;7265.818354541178;7287.963560182166;7289.380402665833;6488.059231411513;6560.606363618198;6571;6573.276939536551;6576.2766095730385;6804.387605115563;6806.319368063154;6811.625360605214;6812.829679258059;6813.4549236061985 19:53:18 INFO - PROCESS | 3407 | |4;prototype.html;339.4772051041396;340.75295410827135;347.09235349560873;349.61542303466183;351.7994742996493;5720.79977200798;5748.453896879795;5822.970885145568;5828.271466066742;5860.208871802311;5552.805651802188;5718.42815718429;5718.857028574277;5730.541556675466;5748.223989761381;4506.66200034997;4508.661850361236;4510.819567217315;4514;4516.728996260218;4304.655627549789;4387.188370151533;4411.095725376306;4494.9325760113625;4512.503624601291;4456.910861782762;4475.373447717306;4476.283794592866;4478.104379124188;4489.349044388562;4493.662975276851;4496.505384407713;4502.662300327472;4503.752293623849;4522.796474158671;3987.441758153861;3990.6408423241755;3995.960040399588;3996.840126394941;4003.719739618228;5450.373207081197;5590.524805391547;5610.158476228557;5611.3546942101775;5611.523020543259;5227.634065615409;5241.030409374278;5268.262443257947;5268.525832675077;5269.235960785703;5870.589058765888;6172.29018662855;6179.62922224668;6185.87628247437;6189.16446279751;4325.675574331937;4367.061081867382;4442.8667139985855;4443.777811109431;4444.2444784386735;6350.174477317965;6418.679066046679;6422.068800023971;6429.035644653292;6439.259485159173;4503.392042074278;4508.504064552896;4512.774361281923;4514.413126293561;4517.932231016537;4468.821247150143;4562.247229207143;4568.063546972929;4572.222722137245;4578.40480737502;5209;5210.635255532076;5212.713300768494;5216.400113986864;5217.478252174752;6126.264848218153;6165.691715414301;6169.722362493699;6169.907451388232;6176.876462470816;1596.8243493215737;1623.9431619893246;1624.8293929137271;1626.3901037111084;1631.5023917705214;1087.7661302819931;1106.4744246483017;1116.776644671069;1118.183725880112;1120.5573798349606;5851.561132915049;5861.062230043172;5863.501602363762;5869;5869.647821130746;6343.143675603735;6398.2641996170105;6410.230772307353;6410.967945160244;6411.166548348778;5803.88392232153;5820.505257053113;5836.854078648068;5845.853853653693;5856.648601083949;3318.4026875162704;3429.3998550253605;3429.451287793941;3438.5186073949667;3438.673326034023;6633.701483433257;6637.369449902251;6645.435138013323;6647.268800431949;6685.331466853373;6478.1578394808375;6501.772437964649;6508.088867558546;6508.479321654257;6509.511786616023;6513.120728701565;6644.966775166094;6654.3345665434035;6660.800175994728;6662.533622646465;6183.072539119168;6299.685015749286;6359.618422894641;6359.872802544016;6361.809145725636;6213.565050446426;6307.684615769285;6308.684565771785;6320.778772742932;6333.619982801047;6669.533132680665;6671.166104236971;6677.29888361715;6680.966595166993;6684.197896252481;4317.8272869084885;4356.237658409702;4390.626796722187;4392.582704643054;4393.692441529191;6322.968385158229;6328.0507923809955;6328.303886572381;6345.17512723343;6348.492120630246;6172.722227499863;6179.567430279837;6183.505319574333;6184.690765461799;6236.376362363727;6085.1785009023215;6172.969135154295;6174.9073763892675;6179.6910154493;6186.443220110212;6113.358097399709;6130.141780150693;6131.632102073711;6133.294671112879;6137.938620613737;6255.499560035278;6259.466430724319;6262.2172228471445;6295.842603934938;6322.241331040304;5911.91132133027;6067.514598831995;6067.878642427215;6072.392760724069;6075.939240607714 19:53:18 INFO - PROCESS | 3407 | |5;yui.html;750.6734570461849;755.6259651472518;756.9545827250362;771.1632878327015;821.3059964330141;13587.592372228824;13771.793423098636;13795.448182072705;13849.09980851244;13855.792163117561;12873.291968941705;12875.678108047303;12906.677333066678;12919.418626161822;12937.935310323435;666.6966530228734;677.6239187251099;804.264098350009;814.0963530481162;814.6944895664126;803.6222975201646;817.5585184000632;822.9259366657;823.2631794543879;823.7240524424325;852.846487632229;855.110684887716;860.496609483453;861.7199410191681;868.8479516084692;692.9965350173242;701.043076200982;702.4626160986849;837.3217693668088;863.1584205399748;631.2204427531994;632.5793347423958;633.1515768869737;637.2735082006516;637.5377851057992;12973.805392919114;13037.674058148623;13060.673483162902;13065.738685226337;13075;12155.574554890625;12614;12615.621531353981;12630.557930472389;13070.673233169151;10147.797044059078;10565.524903530399;10634.36193828365;10791.892081079246;10817.513211905483;3599.208174201671;3617.2584620152807;3673.1184515716304;3690.7231957603285;3764.1154328732728;46927.296090558666;47267.763661182165;47371.76314118442;47618.285725713795;47693;9295.860562091573;9428.71713848572;9657.22742180624;9842.655507057361;9906.504674766233;17432;17480.388186413667;17488.5627859302;17489.125543722763;17494.387696430564;7504.212057733968;7673.846523069507;7719.961400192963;7861.371090312761;7998.4001199910235;4280.422143010716;4307.806148723253;4312.611864932172;4331.133773245364;4357.978210108992;3067.9386412272074;3117.0960421477516;3156.5896433463963;3156.9052928412184;3161.936761264808;581.0847914534625;582.5892745614332;586.598180246524;593.5311104227698;604.1360853978765;628.9465395441347;649.0912722188973;652.7519542573791;659.6767583883862;660.4287291492824;8004.359651227888;9271.67549135777;9407;9594.328397012143;9660.32377733552;518;596.6002778138658;687.4156966578369;718.7628082732685;727.3817255332925;3982.880513584597;4032.858849940238;4094.8566800161852;4216.557261487561;4302.462192225972;54312.45687543153;55325;55547.72226138844;55669.72165139148;55725.72137139289;46242.30636540455;46519;47120.29319560209;48290.7563865423;48709.512904871204;43437.131257374676;44034;44203;44340.55659443364;45863.77068114705;8211.137830527947;8390.622421991147;8616.698415555426;8659.653613855375;8848.20366167048;32152.19619509531;32847;33250.33499329951;33437.33125337528;33442.16394590155;38393.4240986391;39669.60330396659;40733;42224.57775422207;42466;12057.698557536132;12218.816717749418;12287.508499659914;12323.50705971787;13006.80489792635;12183.269003859798;12186.939065304618;12281.01751859867;13119.540816071392;13225.140365876186;11189.38458384764;11801.822972655245;11835.881641183478;11873.940630296793;11995.82006269924;11182.608608698656;11551;11596.246243994114;11760;12140.089493288215;11133.721656958642;11608.941955290169;11651.184417090722;11882;11943.343116128697;9099.49952752605;9228.907710922806;9408.95295523518;9410.52947352616;9542.809143817223;8747;9043.954780226057;9070.365074444726;9566.186874115778;9624.951875240578 19:53:18 INFO - PROCESS | 3407 | __end_tp_report 19:53:18 INFO - PROCESS | 3407 | __start_cc_report 19:53:18 INFO - PROCESS | 3407 | _x_x_mozilla_cycle_collect,738 19:53:18 INFO - PROCESS | 3407 | __end_cc_report 19:53:18 INFO - PROCESS | 3407 | __startTimestamp1452916398732__endTimestamp 19:53:18 INFO - PROCESS | 3407 | 19:53:18 INFO - PROCESS | 3407 | ------- Summary: start ------- 19:53:18 INFO - PROCESS | 3407 | Number of tests: 6 19:53:18 INFO - PROCESS | 3407 | 19:53:18 INFO - PROCESS | 3407 | [#0] dojo.html Cycles:165 Average:5088.64 Median:5284.21 stddev:563.30 (10.7%) stddev-sans-first:540.73 19:53:18 INFO - PROCESS | 3407 | Values: 3002.0 3027.6 3065.1 3082.5 3105.7 4878.1 4973.6 5068.1 5076.3 5104.7 5110.7 5122.6 5125.3 5140.7 5168.2 4603.9 4621.5 4636.1 4694.9 4703.6 4727.8 4739.7 4779.0 4786.6 4804.7 4536.5 4599.7 4605.6 4656.3 4668.5 4621.6 4622.4 4624.1 4633.4 4652.4 4604.8 4615.4 4622.4 4631.3 4653.5 4811.1 4872.2 4967.5 4976.5 5007.8 5463.1 5470.5 5478.8 5480.1 5483.3 5277.4 5495.9 5499.7 5503.4 5507.8 5038.9 5189.2 5225.5 5251.1 5284.2 5620.6 5625.9 5628.0 5629.0 5633.9 5256.5 5325.9 5431.2 5448.0 5449.1 5449.8 5468.0 5485.5 5491.3 5536.1 5421.2 5475.2 5478.9 5478.9 5486.4 5288.4 5360.1 5452.8 5477.5 5523.1 4233.6 4238.3 4244.8 4279.3 4283.1 3767.0 3794.9 3801.1 3814.9 3830.6 5000.0 5067.5 5083.7 5133.0 5199.8 5506.4 5514.4 5532.0 5534.7 5535.4 5144.9 5176.3 5180.7 5182.3 5224.0 4617.1 4684.0 4751.7 4791.0 4822.4 5665.9 5721.6 5721.7 5727.9 5729.3 5211.8 5479.8 5493.6 5499.9 5541.8 5593.1 5689.3 5712.1 5738.3 5769.0 5373.1 5376.5 5382.1 5382.8 5387.1 5233.7 5349.8 5441.2 5443.5 5505.2 5381.9 5404.5 5404.9 5405.8 5450.5 5321.5 5359.7 5374.0 5383.5 5426.7 5119.1 5196.7 5268.3 5290.5 5296.4 5426.5 5440.3 5443.7 5461.2 5483.5 5281.9 5286.9 5288.6 5292.2 5295.0 19:53:18 INFO - PROCESS | 3407 | 19:53:18 INFO - PROCESS | 3407 | [#1] ext.html Cycles:180 Average:48750.69 Median:20203.99 stddev:87633.30 (433.7%) stddev-sans-first:87804.31 19:53:18 INFO - PROCESS | 3407 | Values: 519.6 521.8 532.1 561.9 578.1 28775.6 29233.7 35921.6 36684.8 36734.4 39203.8 39427.2 39581.8 39726.2 39811.0 8325.3 8526.1 8532.9 8533.6 8538.1 8336.8 8410.4 8478.0 8478.3 8482.8 8465.2 8553.6 8697.9 8721.1 8725.4 8586.1 8610.8 8622.4 8679.8 8679.9 8492.7 8618.0 8626.6 8629.4 8638.7 39445.6 40154.0 40228.8 40292.2 40325.2 3376.9 3836.3 3839.2 3855.2 3952.6 29070.1 29162.1 29230.7 29239.3 30537.8 3380.3 3442.6 3464.2 3475.0 3673.5 265133.0 265468.0 265501.0 265928.0 266073.7 58351.0 58717.4 58863.0 58951.0 59005.7 62167.7 62758.7 62881.0 62893.4 62901.4 13964.0 13972.4 14064.6 14149.9 14157.2 10826.7 10979.9 11018.3 11060.2 11078.0 18235.6 19532.0 19744.1 19858.0 19887.5 6399.0 7487.3 7613.3 7887.3 7891.3 901.3 934.4 1025.2 1049.4 1111.3 28364.9 28427.3 28836.3 28927.7 29589.6 1074.3 1096.0 1107.4 1117.1 1146.9 15122.2 15202.4 15603.7 15823.3 16291.1 400924.0 406748.0 445274.0 449274.0 489758.0 53079.7 53635.5 53864.0 53912.0 54083.2 1345.9 1360.8 1362.3 1368.7 1385.7 25739.5 30456.2 30477.7 30843.2 31049.0 49113.3 50200.7 50245.0 50295.0 50304.2 257557.0 258385.0 259035.0 259107.0 259237.0 32927.8 33181.0 33411.5 33625.3 33640.7 43012.1 43470.0 43967.1 43984.0 44001.3 36257.0 36466.0 36540.1 37528.0 37653.0 35590.6 35993.6 36893.6 36944.1 37074.8 35990.5 35994.5 36320.0 37868.1 38715.8 29039.6 31195.4 32799.5 33166.2 33198.8 24613.9 24795.5 25074.7 25405.2 25427.9 19:53:18 INFO - PROCESS | 3407 | 19:53:18 INFO - PROCESS | 3407 | [#2] jquery.html Cycles:180 Average:25635.53 Median:474.75 stddev:82203.74 (17315.3%) stddev-sans-first:82412.42 19:53:18 INFO - PROCESS | 3407 | Values: 356.9 360.7 365.8 368.4 371.2 13567.9 13833.2 15381.2 15927.6 16813.3 14596.1 15264.7 15436.7 15802.4 16407.8 5168.8 5345.8 5347.7 5348.2 5356.8 3972.6 4094.8 5260.9 5348.3 5498.6 5627.0 5631.1 5657.2 5673.5 5689.5 5421.5 5600.9 5605.8 5640.1 5640.7 4844.2 4974.4 4975.5 4975.8 4977.8 12157.8 13253.7 17820.5 18523.4 18587.7 1887.1 2066.4 2072.5 2237.6 2316.6 8780.7 9208.3 9575.2 11363.8 12522.4 1813.3 1819.9 1843.7 1852.9 1885.4 56942.7 57466.9 59049.4 59391.0 60567.4 8885.5 9150.2 9500.3 9515.0 9520.5 12174.0 12227.1 12228.0 12267.8 12322.3 6843.9 7050.6 7058.1 7089.5 7113.3 6682.7 6791.0 6846.1 6880.2 6963.6 3819.8 4004.4 4063.0 4197.5 4329.2 1655.5 1766.0 1775.9 1798.8 1834.3 415.4 419.5 874.7 939.8 1010.0 8840.6 9828.7 10431.3 10462.9 10734.4 459.2 467.5 468.9 473.6 475.9 5801.0 5948.1 5996.3 6034.6 6101.4 450564.0 451029.0 494283.0 548314.0 555091.0 70435.0 73865.0 74676.0 76244.0 77409.2 461.8 473.3 487.1 505.2 505.2 9997.7 10037.3 10047.7 10122.1 10312.4 30604.5 31008.5 31106.8 31176.7 31355.4 37567.8 37940.4 39127.0 39395.2 41577.0 7030.2 7220.4 7459.7 9719.6 9734.6 10922.2 10975.5 11223.8 11351.5 11816.5 6993.0 7177.2 7188.5 7293.1 9486.3 7302.6 7364.9 7702.7 7705.3 7755.8 7542.1 7593.9 7630.5 7633.6 7648.6 9781.5 10006.8 10016.7 10133.2 10289.9 10452.4 10503.5 10604.5 10655.2 10684.6 19:53:18 INFO - PROCESS | 3407 | 19:53:18 INFO - PROCESS | 3407 | [#3] mootools.html Cycles:180 Average:5655.93 Median:6039.27 stddev:2955.33 (48.9%) stddev-sans-first:2945.55 19:53:18 INFO - PROCESS | 3407 | Values: 1308.8 1372.2 1408.3 1530.4 1801.7 7081.5 7228.3 7679.5 7790.0 7827.0 7388.9 7492.2 7495.2 7506.8 7565.6 2016.7 2255.8 2280.8 2281.0 2290.1 2063.5 2288.9 2349.1 2352.2 2353.5 2318.0 2356.6 2364.5 2370.7 2386.3 2296.7 2312.5 2320.9 2321.4 2370.7 2327.1 2343.3 2350.0 2351.5 2353.6 8022.6 8055.0 8075.6 8083.6 8102.6 4935.5 4994.9 4996.9 5036.7 5049.8 3156.2 3169.8 3215.6 3253.0 3278.3 1010.2 1039.9 1066.7 1078.3 1091.7 11133.0 11164.4 11187.4 11198.6 11207.6 4414.8 4431.4 4503.1 4508.3 4527.2 9664.3 9746.5 9752.7 9755.8 9765.1 5088.5 5096.9 5097.7 5099.8 5100.8 4555.3 4587.4 4595.5 4645.6 4651.5 3531.2 3608.4 3756.8 3837.1 3888.4 1198.6 1205.1 1207.1 1215.8 1226.5 1049.1 1069.6 1074.9 1218.1 1337.4 7443.6 7492.6 7518.4 7542.7 7544.3 1082.9 1098.4 1100.7 1111.2 1113.4 5943.6 5950.2 6029.7 6033.8 6044.8 9581.8 9942.3 9952.6 10046.2 10055.5 9628.5 9837.2 9960.9 9962.0 9969.2 7586.1 7634.7 7646.0 7651.7 7651.9 7302.7 7333.3 7371.2 7385.6 7422.7 8830.9 8842.9 8954.3 9061.6 9064.0 8964.3 9071.4 9224.4 9236.3 9258.3 7199.0 7303.2 7304.1 7306.1 7306.4 6797.8 7192.1 7524.3 7543.7 7771.5 7155.9 7164.4 7226.1 7273.9 7298.6 6930.9 7038.1 7076.4 7119.8 7131.9 7243.6 7251.0 7265.8 7288.0 7289.4 6488.1 6560.6 6571.0 6573.3 6576.3 6804.4 6806.3 6811.6 6812.8 6813.5 19:53:18 INFO - PROCESS | 3407 | 19:53:18 INFO - PROCESS | 3407 | [#4] prototype.html Cycles:180 Average:5187.37 Median:5832.56 stddev:1538.57 (26.4%) stddev-sans-first:1499.24 19:53:18 INFO - PROCESS | 3407 | Values: 339.5 340.8 347.1 349.6 351.8 5720.8 5748.5 5823.0 5828.3 5860.2 5552.8 5718.4 5718.9 5730.5 5748.2 4506.7 4508.7 4510.8 4514.0 4516.7 4304.7 4387.2 4411.1 4494.9 4512.5 4456.9 4475.4 4476.3 4478.1 4489.3 4493.7 4496.5 4502.7 4503.8 4522.8 3987.4 3990.6 3996.0 3996.8 4003.7 5450.4 5590.5 5610.2 5611.4 5611.5 5227.6 5241.0 5268.3 5268.5 5269.2 5870.6 6172.3 6179.6 6185.9 6189.2 4325.7 4367.1 4442.9 4443.8 4444.2 6350.2 6418.7 6422.1 6429.0 6439.3 4503.4 4508.5 4512.8 4514.4 4517.9 4468.8 4562.2 4568.1 4572.2 4578.4 5209.0 5210.6 5212.7 5216.4 5217.5 6126.3 6165.7 6169.7 6169.9 6176.9 1596.8 1623.9 1624.8 1626.4 1631.5 1087.8 1106.5 1116.8 1118.2 1120.6 5851.6 5861.1 5863.5 5869.0 5869.6 6343.1 6398.3 6410.2 6411.0 6411.2 5803.9 5820.5 5836.9 5845.9 5856.6 3318.4 3429.4 3429.5 3438.5 3438.7 6633.7 6637.4 6645.4 6647.3 6685.3 6478.2 6501.8 6508.1 6508.5 6509.5 6513.1 6645.0 6654.3 6660.8 6662.5 6183.1 6299.7 6359.6 6359.9 6361.8 6213.6 6307.7 6308.7 6320.8 6333.6 6669.5 6671.2 6677.3 6681.0 6684.2 4317.8 4356.2 4390.6 4392.6 4393.7 6323.0 6328.1 6328.3 6345.2 6348.5 6172.7 6179.6 6183.5 6184.7 6236.4 6085.2 6173.0 6174.9 6179.7 6186.4 6113.4 6130.1 6131.6 6133.3 6137.9 6255.5 6259.5 6262.2 6295.8 6322.2 5911.9 6067.5 6067.9 6072.4 6075.9 19:53:18 INFO - PROCESS | 3407 | 19:53:18 INFO - PROCESS | 3407 | [#5] yui.html Cycles:180 Average:13443.58 Median:46380.65 stddev:15074.00 (32.5%) stddev-sans-first:15086.14 19:53:18 INFO - PROCESS | 3407 | Values: 750.7 755.6 757.0 771.2 821.3 13587.6 13771.8 13795.4 13849.1 13855.8 12873.3 12875.7 12906.7 12919.4 12937.9 666.7 677.6 804.3 814.1 814.7 803.6 817.6 822.9 823.3 823.7 852.8 855.1 860.5 861.7 868.8 693.0 701.0 702.5 837.3 863.2 631.2 632.6 633.2 637.3 637.5 12973.8 13037.7 13060.7 13065.7 13075.0 12155.6 12614.0 12615.6 12630.6 13070.7 10147.8 10565.5 10634.4 10791.9 10817.5 3599.2 3617.3 3673.1 3690.7 3764.1 46927.3 47267.8 47371.8 47618.3 47693.0 9295.9 9428.7 9657.2 9842.7 9906.5 17432.0 17480.4 17488.6 17489.1 17494.4 7504.2 7673.8 7720.0 7861.4 7998.4 4280.4 4307.8 4312.6 4331.1 4358.0 3067.9 3117.1 3156.6 3156.9 3161.9 581.1 582.6 586.6 593.5 604.1 628.9 649.1 652.8 659.7 660.4 8004.4 9271.7 9407.0 9594.3 9660.3 518.0 596.6 687.4 718.8 727.4 3982.9 4032.9 4094.9 4216.6 4302.5 54312.5 55325.0 55547.7 55669.7 55725.7 46242.3 46519.0 47120.3 48290.8 48709.5 43437.1 44034.0 44203.0 44340.6 45863.8 8211.1 8390.6 8616.7 8659.7 8848.2 32152.2 32847.0 33250.3 33437.3 33442.2 38393.4 39669.6 40733.0 42224.6 42466.0 12057.7 12218.8 12287.5 12323.5 13006.8 12183.3 12186.9 12281.0 13119.5 13225.1 11189.4 11801.8 11835.9 11873.9 11995.8 11182.6 11551.0 11596.2 11760.0 12140.1 11133.7 11608.9 11651.2 11882.0 11943.3 9099.5 9228.9 9409.0 9410.5 9542.8 8747.0 9044.0 9070.4 9566.2 9625.0 19:53:18 INFO - PROCESS | 3407 | -------- Summary: end -------- 19:53:18 INFO - PROCESS | 3407 | 19:53:19 INFO - TEST-INFO | 3407: exit 0 19:53:19 INFO - TEST-OK | dromaeo_css | took 1111960ms 19:53:19 INFO - TEST-START | kraken 19:53:19 INFO - operating with platform_type : linux_ 19:53:19 INFO - Initialising browser for kraken test... 19:53:19 INFO - TEST-INFO | started process 3604 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcGbGxq/profile http://localhost:60704/getInfo.html) 19:53:23 INFO - PROCESS | 3604 | __metrics Screen width/height:1600/1200 19:53:23 INFO - PROCESS | 3604 | colorDepth:24 19:53:23 INFO - PROCESS | 3604 | Browser inner width/height: 1024/697 19:53:23 INFO - PROCESS | 3604 | __metrics 19:53:23 INFO - PROCESS | 3604 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:53:23 INFO - PROCESS | 3604 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:53:24 INFO - TEST-INFO | 3604: exit 0 19:53:24 INFO - Browser initialized. 19:53:24 INFO - Running cycle 1/1 for kraken test... 19:53:24 INFO - TEST-INFO | started process 3687 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcGbGxq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:53:36 INFO - PROCESS | 3687 | RSS: Main: 150978560 19:53:36 INFO - PROCESS | 3687 | 19:53:38 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60704/tests/kraken/driver.html?testName=audio-beat-detection) 19:53:39 INFO - PROCESS | 3687 | RSS: Main: 187617280 19:53:39 INFO - PROCESS | 3687 | 19:53:41 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60704/tests/kraken/driver.html?testName=audio-dft) 19:53:42 INFO - PROCESS | 3687 | RSS: Main: 178024448 19:53:42 INFO - PROCESS | 3687 | 19:53:45 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60704/tests/kraken/driver.html?testName=audio-fft) 19:53:45 INFO - PROCESS | 3687 | RSS: Main: 161263616 19:53:45 INFO - PROCESS | 3687 | 19:53:47 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60704/tests/kraken/driver.html?testName=audio-oscillator) 19:53:48 INFO - PROCESS | 3687 | RSS: Main: 165220352 19:53:48 INFO - PROCESS | 3687 | 19:53:50 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60704/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:53:51 INFO - PROCESS | 3687 | RSS: Main: 165502976 19:53:51 INFO - PROCESS | 3687 | 19:53:54 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60704/tests/kraken/driver.html?testName=imaging-darkroom) 19:53:54 INFO - PROCESS | 3687 | RSS: Main: 166526976 19:53:54 INFO - PROCESS | 3687 | 19:53:58 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60704/tests/kraken/driver.html?testName=imaging-desaturate) 19:53:58 INFO - PROCESS | 3687 | RSS: Main: 166563840 19:53:58 INFO - PROCESS | 3687 | 19:54:01 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60704/tests/kraken/driver.html?testName=json-parse-financial) 19:54:01 INFO - PROCESS | 3687 | RSS: Main: 167362560 19:54:01 INFO - PROCESS | 3687 | 19:54:03 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60704/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:54:04 INFO - PROCESS | 3687 | RSS: Main: 176955392 19:54:04 INFO - PROCESS | 3687 | 19:54:05 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60704/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:54:06 INFO - PROCESS | 3687 | RSS: Main: 173469696 19:54:06 INFO - PROCESS | 3687 | 19:54:08 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60704/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:54:09 INFO - PROCESS | 3687 | RSS: Main: 184705024 19:54:09 INFO - PROCESS | 3687 | 19:54:11 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:54:12 INFO - PROCESS | 3687 | RSS: Main: 192303104 19:54:12 INFO - PROCESS | 3687 | 19:54:14 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:54:15 INFO - PROCESS | 3687 | RSS: Main: 190959616 19:54:15 INFO - PROCESS | 3687 | 19:54:16 INFO - PROCESS | 3687 | Cycle 1(1): loaded http://localhost:60704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60704/tests/kraken/driver.html?testName=ai-astar) 19:54:17 INFO - PROCESS | 3687 | RSS: Main: 250798080 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | __start_tp_report 19:54:17 INFO - PROCESS | 3687 | _x_x_mozilla_page_load 19:54:17 INFO - PROCESS | 3687 | _x_x_mozilla_page_load_details 19:54:17 INFO - PROCESS | 3687 | |i|pagename|runs| 19:54:17 INFO - PROCESS | 3687 | |0;ai-astar;108;111;105;110;110;109;99;109;108;109 19:54:17 INFO - PROCESS | 3687 | |1;audio-beat-detection;152;126;154;169;130;149;149;133;165;125 19:54:17 INFO - PROCESS | 3687 | |2;audio-dft;161;161;160;158;161;159;169;163;162;161 19:54:17 INFO - PROCESS | 3687 | |3;audio-fft;72;74;104;93;75;72;72;115;96;74 19:54:17 INFO - PROCESS | 3687 | |4;audio-oscillator;96;94;141;96;95;97;150;96;96;149 19:54:17 INFO - PROCESS | 3687 | |5;imaging-gaussian-blur;109;109;109;109;109;108;109;109;109;109 19:54:17 INFO - PROCESS | 3687 | |6;imaging-darkroom;147;146;145;147;145;146;145;146;147;146 19:54:17 INFO - PROCESS | 3687 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;96 19:54:17 INFO - PROCESS | 3687 | |8;json-parse-financial;59;56;56;55;55;57;55;65;54;53 19:54:17 INFO - PROCESS | 3687 | |9;json-stringify-tinderbox;68;68;68;68;68;69;68;67;68;67 19:54:17 INFO - PROCESS | 3687 | |10;stanford-crypto-aes;81;81;88;91;82;82;83;83;84;84 19:54:17 INFO - PROCESS | 3687 | |11;stanford-crypto-ccm;125;123;115;119;118;116;122;126;125;113 19:54:17 INFO - PROCESS | 3687 | |12;stanford-crypto-pbkdf2;139;127;140;142;157;141;141;139;144;144 19:54:17 INFO - PROCESS | 3687 | |13;stanford-crypto-sha256-iterative;68;65;69;66;70;68;66;71;65;66 19:54:17 INFO - PROCESS | 3687 | __end_tp_report 19:54:17 INFO - PROCESS | 3687 | __start_cc_report 19:54:17 INFO - PROCESS | 3687 | _x_x_mozilla_cycle_collect,946 19:54:17 INFO - PROCESS | 3687 | __end_cc_report 19:54:17 INFO - PROCESS | 3687 | __startTimestamp1452916457129__endTimestamp 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | ------- Summary: start ------- 19:54:17 INFO - PROCESS | 3687 | Number of tests: 14 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.50 stddev:3.49 (3.2%) stddev-sans-first:3.70 19:54:17 INFO - PROCESS | 3687 | Values: 108.0 111.0 105.0 110.0 110.0 109.0 99.0 109.0 108.0 109.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:150.50 stddev:15.87 (10.5%) stddev-sans-first:16.64 19:54:17 INFO - PROCESS | 3687 | Values: 152.0 126.0 154.0 169.0 130.0 149.0 149.0 133.0 165.0 125.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:2.99 (1.9%) stddev-sans-first:3.17 19:54:17 INFO - PROCESS | 3687 | Values: 161.0 161.0 160.0 158.0 161.0 159.0 169.0 163.0 162.0 161.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#3] audio-fft Cycles:10 Average:84.70 Median:74.00 stddev:15.97 (21.6%) stddev-sans-first:16.26 19:54:17 INFO - PROCESS | 3687 | Values: 72.0 74.0 104.0 93.0 75.0 72.0 72.0 115.0 96.0 74.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:96.00 stddev:24.73 (25.8%) stddev-sans-first:25.63 19:54:17 INFO - PROCESS | 3687 | Values: 96.0 94.0 141.0 96.0 95.0 97.0 150.0 96.0 96.0 149.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:54:17 INFO - PROCESS | 3687 | Values: 109.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 109.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 19:54:17 INFO - PROCESS | 3687 | Values: 147.0 146.0 145.0 147.0 145.0 146.0 145.0 146.0 147.0 146.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:54:17 INFO - PROCESS | 3687 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:3.41 (6.1%) stddev-sans-first:3.49 19:54:17 INFO - PROCESS | 3687 | Values: 59.0 56.0 56.0 55.0 55.0 57.0 55.0 65.0 54.0 53.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 19:54:17 INFO - PROCESS | 3687 | Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 67.0 68.0 67.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:3.21 (3.8%) stddev-sans-first:3.23 19:54:17 INFO - PROCESS | 3687 | Values: 81.0 81.0 88.0 91.0 82.0 82.0 83.0 83.0 84.0 84.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:122.50 stddev:4.64 (3.8%) stddev-sans-first:4.58 19:54:17 INFO - PROCESS | 3687 | Values: 125.0 123.0 115.0 119.0 118.0 116.0 122.0 126.0 125.0 113.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:141.50 stddev:7.29 (5.2%) stddev-sans-first:7.68 19:54:17 INFO - PROCESS | 3687 | Values: 139.0 127.0 140.0 142.0 157.0 141.0 141.0 139.0 144.0 144.0 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - PROCESS | 3687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:2.12 (3.1%) stddev-sans-first:2.24 19:54:17 INFO - PROCESS | 3687 | Values: 68.0 65.0 69.0 66.0 70.0 68.0 66.0 71.0 65.0 66.0 19:54:17 INFO - PROCESS | 3687 | -------- Summary: end -------- 19:54:17 INFO - PROCESS | 3687 | 19:54:17 INFO - TEST-INFO | 3687: exit 0 19:54:18 INFO - TEST-OK | kraken | took 58699ms 19:54:18 INFO - TEST-START | v8_7 19:54:18 INFO - operating with platform_type : linux_ 19:54:18 INFO - Initialising browser for v8_7 test... 19:54:18 INFO - TEST-INFO | started process 3938 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX_If4A/profile http://localhost:60704/getInfo.html) 19:54:22 INFO - PROCESS | 3938 | __metrics Screen width/height:1600/1200 19:54:22 INFO - PROCESS | 3938 | colorDepth:24 19:54:22 INFO - PROCESS | 3938 | Browser inner width/height: 1024/697 19:54:22 INFO - PROCESS | 3938 | __metrics 19:54:22 INFO - PROCESS | 3938 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:54:22 INFO - PROCESS | 3938 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:54:23 INFO - TEST-INFO | 3938: exit 0 19:54:23 INFO - Browser initialized. 19:54:23 INFO - Running cycle 1/1 for v8_7 test... 19:54:23 INFO - TEST-INFO | started process 4025 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX_If4A/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:54:34 INFO - PROCESS | 4025 | RSS: Main: 150474752 19:54:34 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | Cycle 1(1): loaded http://localhost:60704/tests/v8_7/run.html (next: http://localhost:60704/tests/v8_7/run.html) 19:54:57 INFO - PROCESS | 4025 | RSS: Main: 523272192 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | __start_tp_report 19:54:57 INFO - PROCESS | 4025 | _x_x_mozilla_page_load 19:54:57 INFO - PROCESS | 4025 | _x_x_mozilla_page_load_details 19:54:57 INFO - PROCESS | 4025 | |i|pagename|runs| 19:54:57 INFO - PROCESS | 4025 | |0;Richards;167.7008217340265 19:54:57 INFO - PROCESS | 4025 | |1;DeltaBlue;189.000189000189 19:54:57 INFO - PROCESS | 4025 | |2;Encrypt;281.5315315315315 19:54:57 INFO - PROCESS | 4025 | |3;Decrypt;5268.421052631579 19:54:57 INFO - PROCESS | 4025 | |4;RayTrace;1988.0715705765408 19:54:57 INFO - PROCESS | 4025 | |5;Earley;789.8894154818325 19:54:57 INFO - PROCESS | 4025 | |6;Boyer;12543.20987654321 19:54:57 INFO - PROCESS | 4025 | |7;RegExp;43489.36170212766 19:54:57 INFO - PROCESS | 4025 | |8;Splay;571.4285714285714 19:54:57 INFO - PROCESS | 4025 | |9;NavierStokes;4835.748792270531 19:54:57 INFO - PROCESS | 4025 | __end_tp_report 19:54:57 INFO - PROCESS | 4025 | __startTimestamp1452916497559__endTimestamp 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | ------- Summary: start ------- 19:54:57 INFO - PROCESS | 4025 | Number of tests: 10 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | [#0] Richards Cycles:1 Average:167.70 Median:167.70 stddev:0.00 (0.0%) 19:54:57 INFO - PROCESS | 4025 | Values: 167.7 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | [#1] DeltaBlue Cycles:1 Average:189.00 Median:189.00 stddev:0.00 (0.0%) 19:54:57 INFO - PROCESS | 4025 | Values: 189.0 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | [#2] Encrypt Cycles:1 Average:281.53 Median:281.53 stddev:0.00 (0.0%) 19:54:57 INFO - PROCESS | 4025 | Values: 281.5 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 19:54:57 INFO - PROCESS | 4025 | Values: 5268.4 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 19:54:57 INFO - PROCESS | 4025 | Values: 1988.1 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 19:54:57 INFO - PROCESS | 4025 | Values: 789.9 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | [#6] Boyer Cycles:1 Average:12543.21 Median:12543.21 stddev:0.00 (0.0%) 19:54:57 INFO - PROCESS | 4025 | Values: 12543.2 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | [#7] RegExp Cycles:1 Average:43489.36 Median:43489.36 stddev:0.00 (0.0%) 19:54:57 INFO - PROCESS | 4025 | Values: 43489.4 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | [#8] Splay Cycles:1 Average:571.43 Median:571.43 stddev:0.00 (0.0%) 19:54:57 INFO - PROCESS | 4025 | Values: 571.4 19:54:57 INFO - PROCESS | 4025 | 19:54:57 INFO - PROCESS | 4025 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:54:57 INFO - PROCESS | 4025 | Values: 4835.7 19:54:57 INFO - PROCESS | 4025 | -------- Summary: end -------- 19:54:57 INFO - PROCESS | 4025 | 19:54:58 INFO - TEST-INFO | 4025: exit 0 19:54:58 INFO - TEST-OK | v8_7 | took 40431ms 19:54:58 INFO - SUITE-END | took 1211s 19:54:58 INFO - Completed test suite (00:20:11) 19:54:58 INFO - Working with test: dromaeo_css 19:54:58 INFO - Generating results file: dromaeo_css 19:54:58 INFO - Working with test: kraken 19:54:58 INFO - Generating results file: kraken 19:54:58 INFO - javascript benchmark 19:54:58 INFO - Working with test: v8_7 19:54:58 INFO - Generating results file: v8_7 19:54:58 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:54:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 19:54:58 INFO - process_Request line: dromaeo_css 6725.32 graph.html#tests=[[72,64,35]] 19:54:58 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:54:58 INFO - process_Request line: kraken 1498.30 graph.html#tests=[[232,64,35]] 19:54:58 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:54:58 INFO - process_Request line: v8_7 18856.72 graph.html#tests=[[230,64,35]] 19:54:58 INFO - RETURN: dromaeo_css: 6725.32 19:54:58 INFO - RETURN: kraken: 1498.30 19:54:58 INFO - RETURN: v8_7: 18856.72 19:54:58 INFO - javascript benchmark 19:54:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3002.0, 3027.6215473065854, 3065.1111177758453, 3082.4913889208283, 3105.6894310568937, 4878.121938051149, 4973.552380285773, 5068.087744206042, 5076.340075790146, 5104.693718376895, 5110.667806592578, 5122.564582010534, 5125.333706618135, 5140.691558506493, 5168.22476628506, 4603.861884143473, 4621.4685311189305, 4636.142313671965, 4694.859154225379, 4703.6472264580125, 4727.810887564493, 4739.691920025204, 4779.0, 4786.617070634358, 4804.735739534324, 4536.455625324949, 4599.747013914233, 4605.608523275509, 4656.301554766778, 4668.509806470306, 4621.630269578425, 4622.399088118523, 4624.09830083134, 4633.4439867215815, 4652.418447694038, 4604.815807367735, 4615.446146462413, 4622.445306563201, 4631.258998560248, 4653.488116307203, 4811.061842940628, 4872.220444728827, 4967.50324967504, 4976.527229913152, 5007.84976450707, 5463.125899856004, 5470.5350045246205, 5478.835634930919, 5480.095784195603, 5483.341998960111, 5277.445868183862, 5495.917561236584, 5499.697516636584, 5503.449655034505, 5507.815412141837, 5038.874028149289, 5189.1697328427645, 5225.4774522548205, 5251.10731175701, 5284.207368894658, 5620.634658747168, 5625.887482250414, 5627.971860140673, 5628.97185514078, 5633.943660563424, 5256.474352564713, 5325.893482130413, 5431.2396264522995, 5448.0, 5449.128139497661, 5449.754761035763, 5467.972660136754, 5485.451454854483, 5491.313585801775, 5536.141898005815, 5421.241026256327, 5475.206095116186, 5478.863028424242, 5478.890422191534, 5486.3690675572025, 5288.418273989858, 5360.115580929181, 5452.781888724486, 5477.452254774491, 5523.061079616475, 4233.640140588084, 4238.258304796648, 4244.766537840386, 4279.33670281107, 4283.100548884707, 3767.03940495172, 3794.9430758538642, 3801.0877389426337, 3814.8664796731982, 3830.578636349999, 4999.950000500021, 5067.543921047123, 5083.74581270935, 5133.0, 5199.818006369759, 5506.394296627368, 5514.365847927459, 5532.0, 5534.667919924817, 5535.418781028015, 5144.897102058013, 5176.327077479904, 5180.7150606717, 5182.326297581366, 5224.007438586732, 4617.145828021827, 4683.95316046842, 4751.714897106184, 4790.952090479121, 4822.397200349957, 5665.886682266414, 5721.599488035881, 5721.713914304268, 5727.914081288784, 5729.28383952006, 5211.843644690665, 5479.780808767764, 5493.611905153853, 5499.862503437446, 5541.750621221974, 5593.133064375028, 5689.317281926195, 5712.143178523089, 5738.340090889601, 5768.971155144365, 5373.11343628297, 5376.542993845567, 5382.111951528111, 5382.784688612568, 5387.084195686664, 5233.738313084406, 5349.759260833194, 5441.238226648352, 5443.455654434525, 5505.201745746925, 5381.946180538144, 5404.459554044564, 5404.918926216032, 5405.783768649368, 5450.509454149145, 5321.54766844807, 5359.678419294854, 5373.9731301343245, 5383.488568585978, 5426.67439953604, 5119.104156772624, 5196.7401629917595, 5268.315119034501, 5290.523852853262, 5296.443873393238, 5426.484483974016, 5440.319960004999, 5443.673379597237, 5461.235427040138, 5483.4516548344845, 5281.9471805281455, 5286.867828304323, 5288.603354748332, 5292.232626269247, 5295.046891559402], "unit": "score", "name": "dojo.html", "value": 5052.306321609654}, {"lowerIsBetter": false, "replicates": [519.5713536332527, 521.7730287325012, 532.1087178975217, 561.8932402843461, 578.0519947286451, 28775.568366474494, 29233.707662923363, 35921.640783592185, 36684.81657591715, 36734.44898326527, 39203.803980980054, 39427.21145577087, 39581.802090989506, 39726.20547589046, 39811.0, 8325.250727434544, 8526.147385261454, 8532.914670853273, 8533.615987280587, 8538.103499132594, 8336.791580210513, 8410.36922230835, 8478.0, 8478.279346255576, 8482.830343393129, 8465.153484651517, 8553.615087321054, 8697.913020869806, 8721.12788721129, 8725.389222754378, 8586.141385861427, 8610.784730381727, 8622.35332350073, 8679.783005424883, 8679.913200867974, 8492.66029358825, 8617.956910215471, 8626.56867156646, 8629.439086459422, 8638.65445382184, 39445.60554394448, 40154.0, 40228.79885600553, 40292.19415611671, 40325.19349612991, 3376.898693039213, 3836.3094642964256, 3839.232153569297, 3855.248226595815, 3952.565217826037, 29070.12789616315, 29162.125136245948, 29230.70769292301, 29239.269018274714, 30537.847310763525, 3380.256343604403, 3442.638522955104, 3464.20323325634, 3474.9826250868837, 3673.540807399075, 265133.0, 265468.0, 265501.0, 265928.0, 266073.66963165253, 58351.0, 58717.41282587205, 58863.0, 58951.0, 59005.704971474865, 62167.689161553906, 62758.68620656867, 62881.0, 62893.37106628967, 62901.370986290465, 13964.0, 13972.441102355791, 14064.578062658136, 14149.85850141506, 14157.221352825694, 10826.729331766612, 10979.890201098047, 11018.283811552223, 11060.225784195029, 11078.0, 18235.556172966593, 19532.0, 19744.11151498186, 19858.0, 19887.502812429804, 6398.968005160037, 7487.3261406473675, 7613.276738709814, 7887.290143887078, 7891.250331218525, 901.3150005995491, 934.4066517761271, 1025.1696126137704, 1049.3651340938775, 1111.3165403277087, 28364.85817570899, 28427.28931776722, 28836.279093022844, 28927.7107228925, 29589.55615665767, 1074.2802322443981, 1096.0135877710125, 1107.3687997841153, 1117.1286396610656, 1146.8623765148236, 15122.168280744445, 15202.391904323924, 15603.708980030355, 15823.287952042187, 16291.103989280704, 400924.0, 406748.0, 445274.0, 449274.0, 489758.0, 53079.734601326745, 53635.463645363045, 53864.0, 53912.0, 54083.188752168746, 1345.8519562848078, 1360.843502997168, 1362.305224335596, 1368.7330970460864, 1385.709001109758, 25739.485210296065, 30456.172629642293, 30477.67549251848, 30843.228919277197, 31049.0, 49113.263301049796, 50200.748996254784, 50245.0, 50295.0, 50304.245436319216, 257557.0, 258385.0, 259035.0, 259107.0, 259237.0, 32927.83536082304, 33181.0, 33411.49882751712, 33625.327493449506, 33640.663593364734, 43012.13975720531, 43470.0, 43967.12065758603, 43984.0, 44001.339979900964, 36257.0, 36466.0, 36540.07679385589, 37528.0, 37653.0, 35590.64409355873, 35993.62803663796, 36893.631063690096, 36944.076398089186, 37074.814625926694, 35990.46014309735, 35994.46008309825, 36320.0, 37868.05329866776, 38715.80642096772, 29039.564406533496, 31195.376092478476, 32799.508007380384, 33166.170845728084, 33198.83400582981, 24613.87693061595, 24795.50408991774, 25074.68631746635, 25405.237842864743, 25427.87286063558], "unit": "score", "name": "ext.html", "value": 18487.891717574126}, {"lowerIsBetter": false, "replicates": [356.89828398906315, 360.7402670077543, 365.7677374866959, 368.436292472517, 371.1611757428211, 13567.932160339209, 13833.170009799394, 15381.230938453074, 15927.601809954756, 16813.327466901308, 14596.124232546055, 15264.69470610587, 15436.691266174697, 15802.367905283774, 16407.83592164078, 5168.844934651957, 5345.812896548621, 5347.7058761768085, 5348.197770334442, 5356.758945847446, 3972.56301806801, 4094.795260236991, 5260.868478288055, 5348.277982472356, 5498.5876059295515, 5627.0, 5631.099024156136, 5657.23627310314, 5673.546116310706, 5689.544836413098, 5421.484958928915, 5600.943990560083, 5605.775768969236, 5640.0693885508845, 5640.717964101778, 4844.176489996674, 4974.353334066548, 4975.477574854624, 4975.7512124394, 4977.776000080005, 12157.756844863054, 13253.668658283523, 17820.46538603844, 18523.35168269104, 18587.721184182246, 1887.1413506854349, 2066.442060643633, 2072.471519762451, 2237.641977283643, 2316.6177580699164, 8780.692675756382, 9208.309376796768, 9575.186109180728, 11363.772724545546, 12522.37388130599, 1813.3471950097953, 1819.8817076890093, 1843.714224295223, 1852.8610354223351, 1885.377825317642, 56942.715286423714, 57466.85066298692, 59049.40950590482, 59391.0, 60567.394326056616, 8885.511296878734, 9150.222231110298, 9500.334976551714, 9515.04849515043, 9520.523973801282, 12174.026077913923, 12227.1440999131, 12228.0, 12267.815982760265, 12322.260664360167, 6843.931560684429, 7050.5769653820935, 7058.082449281561, 7089.468289878177, 7113.288671132948, 6682.732690692318, 6791.0, 6846.075779769767, 6880.208775990725, 6963.582185068912, 3819.8281077351585, 4004.3593025116425, 4063.0248740302704, 4197.538270790211, 4329.15581461612, 1655.5281744702943, 1765.9823401766075, 1775.8756887017785, 1798.7571677823587, 1834.3488061738158, 415.41011763296194, 419.5259356926653, 874.728834061443, 939.8496240601471, 1009.9798004039878, 8840.602172902234, 9828.705138845846, 10431.321964072311, 10462.947685261677, 10734.409607471664, 459.16890428324837, 467.4670875202272, 468.94607120180933, 473.60690626780377, 475.8834085649038, 5801.0, 5948.137520059568, 5996.310424301174, 6034.63792172471, 6101.420365065312, 450564.0, 451029.0, 494283.0, 548314.0, 555091.0, 70435.0, 73865.0, 74676.0, 76244.0, 77409.22590774133, 461.838356575196, 473.2947907617625, 487.12074705157534, 505.20682528430746, 505.21186948360673, 9997.650082247086, 10037.347572408062, 10047.748806279902, 10122.089011988955, 10312.432816195182, 30604.540931885593, 31008.534871976488, 31106.84446577843, 31176.688233118286, 31355.372892542477, 37567.81216093902, 37940.430893537174, 39127.02182445462, 39395.2120957585, 41577.0, 7030.226675065636, 7220.38626716735, 7459.701611935462, 9719.562619682272, 9734.610615575297, 10922.235443518877, 10975.50610222526, 11223.831642525533, 11351.54593816238, 11816.46825892854, 6993.0, 7177.2463891292755, 7188.460865435009, 7293.124825021031, 9486.288528360263, 7302.56184628924, 7364.926350736639, 7702.691892324245, 7705.345045671181, 7755.806104847424, 7542.094948605983, 7593.8860917087395, 7630.542167469969, 7633.580153091633, 7648.61756912141, 9781.510924453607, 10006.812429451726, 10016.696159883122, 10133.189344852246, 10289.9485502572, 10452.425116618659, 10503.474826258504, 10604.469776511298, 10655.200859935381, 10684.57261709523], "unit": "score", "name": "jquery.html", "value": 7268.051595738734}, {"lowerIsBetter": false, "replicates": [1308.8102225177342, 1372.2452651041924, 1408.3310427546915, 1530.387844862055, 1801.7477553142562, 7081.468889833263, 7228.313310235526, 7679.462437629361, 7790.0, 7827.0, 7388.889166662504, 7492.175860655324, 7495.175530691619, 7506.81232969176, 7565.583892885889, 2016.6672499037716, 2255.7631448697857, 2280.817534597228, 2280.9885950570224, 2290.141197051106, 2063.484128967758, 2288.9198878039274, 2349.0721165139844, 2352.1532248390567, 2353.5292941411785, 2318.026428899866, 2356.587597170488, 2364.4798144408287, 2370.7392186859433, 2386.296042667417, 2296.666983287431, 2312.5490529346785, 2320.8723520206468, 2321.361625552978, 2370.7392186859433, 2327.138958585317, 2343.308723926446, 2349.953000939972, 2351.4709190432186, 2353.5528249632684, 8022.598870056532, 8055.03339599246, 8075.596220188967, 8083.595820208966, 8102.5543595102245, 4935.531124543163, 4994.850154495371, 4996.925046124311, 5036.748162591855, 5049.798008079672, 3156.210947263184, 3169.762267829922, 3215.565898603682, 3253.0, 3278.278778668689, 1010.2170817616333, 1039.9168066554657, 1066.6906597086913, 1078.250615822004, 1091.6705536754591, 11133.0, 11164.385958772264, 11187.384693841836, 11198.552057917674, 11207.607733729363, 4414.757188354672, 4431.357453169272, 4503.076869241798, 4508.301213311942, 4527.162474942146, 9664.323497355117, 9746.512674366253, 9752.658656946973, 9755.756106097404, 9765.072318129767, 5088.491150884956, 5096.9490305097215, 5097.668651537712, 5099.770510327045, 5100.821471248562, 4555.339475775994, 4587.4036375271, 4595.517470665599, 4645.628349732014, 4651.511591282867, 3531.2231309111953, 3608.4226523756074, 3756.8121593920196, 3837.1174629835295, 3888.358420860583, 1198.646399312205, 1205.1082199172724, 1207.1368971185468, 1215.7902886627685, 1226.4726167747776, 1049.1134990932649, 1069.572171131538, 1074.9247552671238, 1218.1229514749366, 1337.3714354253486, 7443.627818609048, 7492.625368731542, 7518.398528117737, 7542.6605802739, 7544.283293087148, 1082.875469321038, 1098.373926861697, 1100.741325788439, 1111.216592302441, 1113.3653817324048, 5943.619218232886, 5950.19672344228, 6029.698515074228, 6033.758649653964, 6044.788432404845, 9581.760455988657, 9942.254330925209, 9952.552135153936, 10046.19630429564, 10055.497225138713, 9628.47043412605, 9837.213022958145, 9960.900390995997, 9961.950190249003, 9969.152622027064, 7586.051743531948, 7634.732784352521, 7645.961770191114, 7651.655675494616, 7651.923480765233, 7302.744403945836, 7333.339999400079, 7371.152317483344, 7385.556866588022, 7422.703091876265, 8830.91169088301, 8842.91157088421, 8954.328425368254, 9061.592228349607, 9064.0, 8964.32767542424, 9071.365004449624, 9224.35429519954, 9236.307276954121, 9258.259339252978, 7199.0, 7303.196648368569, 7304.123505179413, 7306.050213472215, 7306.378957788647, 6797.796066118024, 7192.065031545865, 7524.2851929066655, 7543.73596924105, 7771.4559980800805, 7155.856882862209, 7164.426845852424, 7226.060612120601, 7273.890891636735, 7298.598577078312, 6930.896036559355, 7038.120234970629, 7076.363127318566, 7119.786406407816, 7131.893021604784, 7243.637818108968, 7251.0, 7265.818354541178, 7287.963560182166, 7289.380402665833, 6488.059231411513, 6560.606363618198, 6571.0, 6573.276939536551, 6576.2766095730385, 6804.387605115563, 6806.319368063154, 6811.625360605214, 6812.829679258059, 6813.4549236061985], "unit": "score", "name": "mootools.html", "value": 4625.663293260711}, {"lowerIsBetter": false, "replicates": [339.4772051041396, 340.75295410827135, 347.09235349560873, 349.61542303466183, 351.7994742996493, 5720.79977200798, 5748.453896879795, 5822.970885145568, 5828.271466066742, 5860.208871802311, 5552.805651802188, 5718.42815718429, 5718.857028574277, 5730.541556675466, 5748.223989761381, 4506.66200034997, 4508.661850361236, 4510.819567217315, 4514.0, 4516.728996260218, 4304.655627549789, 4387.188370151533, 4411.095725376306, 4494.9325760113625, 4512.503624601291, 4456.910861782762, 4475.373447717306, 4476.283794592866, 4478.104379124188, 4489.349044388562, 4493.662975276851, 4496.505384407713, 4502.662300327472, 4503.752293623849, 4522.796474158671, 3987.441758153861, 3990.6408423241755, 3995.960040399588, 3996.840126394941, 4003.719739618228, 5450.373207081197, 5590.524805391547, 5610.158476228557, 5611.3546942101775, 5611.523020543259, 5227.634065615409, 5241.030409374278, 5268.262443257947, 5268.525832675077, 5269.235960785703, 5870.589058765888, 6172.29018662855, 6179.62922224668, 6185.87628247437, 6189.16446279751, 4325.675574331937, 4367.061081867382, 4442.8667139985855, 4443.777811109431, 4444.2444784386735, 6350.174477317965, 6418.679066046679, 6422.068800023971, 6429.035644653292, 6439.259485159173, 4503.392042074278, 4508.504064552896, 4512.774361281923, 4514.413126293561, 4517.932231016537, 4468.821247150143, 4562.247229207143, 4568.063546972929, 4572.222722137245, 4578.40480737502, 5209.0, 5210.635255532076, 5212.713300768494, 5216.400113986864, 5217.478252174752, 6126.264848218153, 6165.691715414301, 6169.722362493699, 6169.907451388232, 6176.876462470816, 1596.8243493215737, 1623.9431619893246, 1624.8293929137271, 1626.3901037111084, 1631.5023917705214, 1087.7661302819931, 1106.4744246483017, 1116.776644671069, 1118.183725880112, 1120.5573798349606, 5851.561132915049, 5861.062230043172, 5863.501602363762, 5869.0, 5869.647821130746, 6343.143675603735, 6398.2641996170105, 6410.230772307353, 6410.967945160244, 6411.166548348778, 5803.88392232153, 5820.505257053113, 5836.854078648068, 5845.853853653693, 5856.648601083949, 3318.4026875162704, 3429.3998550253605, 3429.451287793941, 3438.5186073949667, 3438.673326034023, 6633.701483433257, 6637.369449902251, 6645.435138013323, 6647.268800431949, 6685.331466853373, 6478.1578394808375, 6501.772437964649, 6508.088867558546, 6508.479321654257, 6509.511786616023, 6513.120728701565, 6644.966775166094, 6654.3345665434035, 6660.800175994728, 6662.533622646465, 6183.072539119168, 6299.685015749286, 6359.618422894641, 6359.872802544016, 6361.809145725636, 6213.565050446426, 6307.684615769285, 6308.684565771785, 6320.778772742932, 6333.619982801047, 6669.533132680665, 6671.166104236971, 6677.29888361715, 6680.966595166993, 6684.197896252481, 4317.8272869084885, 4356.237658409702, 4390.626796722187, 4392.582704643054, 4393.692441529191, 6322.968385158229, 6328.0507923809955, 6328.303886572381, 6345.17512723343, 6348.492120630246, 6172.722227499863, 6179.567430279837, 6183.505319574333, 6184.690765461799, 6236.376362363727, 6085.1785009023215, 6172.969135154295, 6174.9073763892675, 6179.6910154493, 6186.443220110212, 6113.358097399709, 6130.141780150693, 6131.632102073711, 6133.294671112879, 6137.938620613737, 6255.499560035278, 6259.466430724319, 6262.2172228471445, 6295.842603934938, 6322.241331040304, 5911.91132133027, 6067.514598831995, 6067.878642427215, 6072.392760724069, 6075.939240607714], "unit": "score", "name": "prototype.html", "value": 4697.287815428868}, {"lowerIsBetter": false, "replicates": [750.6734570461849, 755.6259651472518, 756.9545827250362, 771.1632878327015, 821.3059964330141, 13587.592372228824, 13771.793423098636, 13795.448182072705, 13849.09980851244, 13855.792163117561, 12873.291968941705, 12875.678108047303, 12906.677333066678, 12919.418626161822, 12937.935310323435, 666.6966530228734, 677.6239187251099, 804.264098350009, 814.0963530481162, 814.6944895664126, 803.6222975201646, 817.5585184000632, 822.9259366657, 823.2631794543879, 823.7240524424325, 852.846487632229, 855.110684887716, 860.496609483453, 861.7199410191681, 868.8479516084692, 692.9965350173242, 701.043076200982, 702.4626160986849, 837.3217693668088, 863.1584205399748, 631.2204427531994, 632.5793347423958, 633.1515768869737, 637.2735082006516, 637.5377851057992, 12973.805392919114, 13037.674058148623, 13060.673483162902, 13065.738685226337, 13075.0, 12155.574554890625, 12614.0, 12615.621531353981, 12630.557930472389, 13070.673233169151, 10147.797044059078, 10565.524903530399, 10634.36193828365, 10791.892081079246, 10817.513211905483, 3599.208174201671, 3617.2584620152807, 3673.1184515716304, 3690.7231957603285, 3764.1154328732728, 46927.296090558666, 47267.763661182165, 47371.76314118442, 47618.285725713795, 47693.0, 9295.860562091573, 9428.71713848572, 9657.22742180624, 9842.655507057361, 9906.504674766233, 17432.0, 17480.388186413667, 17488.5627859302, 17489.125543722763, 17494.387696430564, 7504.212057733968, 7673.846523069507, 7719.961400192963, 7861.371090312761, 7998.4001199910235, 4280.422143010716, 4307.806148723253, 4312.611864932172, 4331.133773245364, 4357.978210108992, 3067.9386412272074, 3117.0960421477516, 3156.5896433463963, 3156.9052928412184, 3161.936761264808, 581.0847914534625, 582.5892745614332, 586.598180246524, 593.5311104227698, 604.1360853978765, 628.9465395441347, 649.0912722188973, 652.7519542573791, 659.6767583883862, 660.4287291492824, 8004.359651227888, 9271.67549135777, 9407.0, 9594.328397012143, 9660.32377733552, 518.0, 596.6002778138658, 687.4156966578369, 718.7628082732685, 727.3817255332925, 3982.880513584597, 4032.858849940238, 4094.8566800161852, 4216.557261487561, 4302.462192225972, 54312.45687543153, 55325.0, 55547.72226138844, 55669.72165139148, 55725.72137139289, 46242.30636540455, 46519.0, 47120.29319560209, 48290.7563865423, 48709.512904871204, 43437.131257374676, 44034.0, 44203.0, 44340.55659443364, 45863.77068114705, 8211.137830527947, 8390.622421991147, 8616.698415555426, 8659.653613855375, 8848.20366167048, 32152.19619509531, 32847.0, 33250.33499329951, 33437.33125337528, 33442.16394590155, 38393.4240986391, 39669.60330396659, 40733.0, 42224.57775422207, 42466.0, 12057.698557536132, 12218.816717749418, 12287.508499659914, 12323.50705971787, 13006.80489792635, 12183.269003859798, 12186.939065304618, 12281.01751859867, 13119.540816071392, 13225.140365876186, 11189.38458384764, 11801.822972655245, 11835.881641183478, 11873.940630296793, 11995.82006269924, 11182.608608698656, 11551.0, 11596.246243994114, 11760.0, 12140.089493288215, 11133.721656958642, 11608.941955290169, 11651.184417090722, 11882.0, 11943.343116128697, 9099.49952752605, 9228.907710922806, 9408.95295523518, 9410.52947352616, 9542.809143817223, 8747.0, 9043.954780226057, 9070.365074444726, 9566.186874115778, 9624.951875240578], "unit": "score", "name": "yui.html", "value": 6272.254593787666}], "name": "dromaeo_css", "value": 6725.318795129242}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 105.0, 110.0, 110.0, 109.0, 99.0, 109.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 154.0, 169.0, 130.0, 149.0, 149.0, 133.0, 165.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 158.0, 161.0, 159.0, 169.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 104.0, 93.0, 75.0, 72.0, 72.0, 115.0, 96.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.7}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 141.0, 96.0, 95.0, 97.0, 150.0, 96.0, 96.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 111.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 147.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 56.0, 56.0, 55.0, 55.0, 57.0, 55.0, 65.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 88.0, 91.0, 82.0, 82.0, 83.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [125.0, 123.0, 115.0, 119.0, 118.0, 116.0, 122.0, 126.0, 125.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [139.0, 127.0, 140.0, 142.0, 157.0, 141.0, 141.0, 139.0, 144.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 69.0, 66.0, 70.0, 68.0, 66.0, 71.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1498.3000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7008217340265], "unit": "score", "name": "Richards", "value": 210.50582599999998}, {"lowerIsBetter": false, "replicates": [189.000189000189], "unit": "score", "name": "DeltaBlue", "value": 349.8303379999999}, {"lowerIsBetter": false, "replicates": [281.5315315315315], "unit": "score", "name": "Encrypt", "value": 945.4749119999998}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12543.20987654321], "unit": "score", "name": "Boyer", "value": 53.133369094488174}, {"lowerIsBetter": false, "replicates": [43489.36170212766], "unit": "score", "name": "RegExp", "value": 20.947306751467718}, {"lowerIsBetter": false, "replicates": [571.4285714285714], "unit": "score", "name": "Splay", "value": 142.60924999999995}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18856.71769724752}]} 19:54:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18856.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1498.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6725.32"}}} 19:54:58 INFO - Return code: 0 19:54:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:54:58 INFO - # TBPL SUCCESS # 19:54:58 INFO - Running post-action listener: _resource_record_post_action 19:54:58 INFO - Running post-run listener: _resource_record_post_run 19:54:59 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 8192; Write bytes: 540307456; Read time: 176; Write time: 589488 19:54:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 8192; Write bytes: 237129728; Read time: 176; Write time: 313216 19:54:59 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 303177728; Read time: 0; Write time: 276272 19:54:59 INFO - Running post-run listener: _upload_blobber_files 19:54:59 INFO - Blob upload gear active. 19:54:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:54:59 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:54:59 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'] 19:54:59 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 19:55:00 INFO - (blobuploader) - INFO - Open directory for files ... 19:55:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:55:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:55:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:01 INFO - (blobuploader) - INFO - Done attempting. 19:55:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:55:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:55:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:02 INFO - (blobuploader) - INFO - Done attempting. 19:55:02 INFO - (blobuploader) - INFO - Iteration through files over. 19:55:02 INFO - Return code: 0 19:55:02 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:55:02 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:55:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f886896138b3a21b648b74ef6962ca3cec0945d02a740c94e14ae497aea8a5bc506221489eb7fd2a6c406569b108a640e998f21f4c456a673a3f1c2107ac7553", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a6bc3fca5edaedff37eddcbae369b771fb99d80db1c3906b6ecef320c6cea60c22fc2960c282c47401899b51e2f34a66802657ff53ae1df91dc41a77bb1617f"} 19:55:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:55:02 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:55:02 INFO - Contents: 19:55:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f886896138b3a21b648b74ef6962ca3cec0945d02a740c94e14ae497aea8a5bc506221489eb7fd2a6c406569b108a640e998f21f4c456a673a3f1c2107ac7553", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a6bc3fca5edaedff37eddcbae369b771fb99d80db1c3906b6ecef320c6cea60c22fc2960c282c47401899b51e2f34a66802657ff53ae1df91dc41a77bb1617f"} 19:55:02 INFO - Running post-run listener: copy_logs_to_upload_dir 19:55:02 INFO - Copying logs to upload dir... 19:55:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:55:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.279224 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-15 19:55:01.622095) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 19:55:01.626168) ========= 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=f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f886896138b3a21b648b74ef6962ca3cec0945d02a740c94e14ae497aea8a5bc506221489eb7fd2a6c406569b108a640e998f21f4c456a673a3f1c2107ac7553", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a6bc3fca5edaedff37eddcbae369b771fb99d80db1c3906b6ecef320c6cea60c22fc2960c282c47401899b51e2f34a66802657ff53ae1df91dc41a77bb1617f"} build_url:https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/NXLlltBtTqyYz2kG9x6gDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f886896138b3a21b648b74ef6962ca3cec0945d02a740c94e14ae497aea8a5bc506221489eb7fd2a6c406569b108a640e998f21f4c456a673a3f1c2107ac7553", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a6bc3fca5edaedff37eddcbae369b771fb99d80db1c3906b6ecef320c6cea60c22fc2960c282c47401899b51e2f34a66802657ff53ae1df91dc41a77bb1617f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 19:55:01.651589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:55:01.652063) ========= 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=f919189b672bc2eeae365d21000001d6-1452905873.186251-2079708519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:55:01.736679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 19:55:01.737003) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 19:55:01.737285) ========= ========= Total master_lag: 0.28 =========