builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1453944338.01 results: success (0) buildid: 20160127143013 builduid: 30e3e19334674674b8ae01904cbf17ed revision: 24320d1e9d99d14e391db8013e88736a6bff4247 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.011761) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.012327) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.012640) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006165 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.060927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.061232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.100502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.100892) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024433 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.147546) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.147865) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.148246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.148561) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-27 17:25:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.4M=0s 2016-01-27 17:25:38 (35.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208290 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.369231) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.369556) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.070164 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.451332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:38.451752) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 24320d1e9d99d14e391db8013e88736a6bff4247 --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 24320d1e9d99d14e391db8013e88736a6bff4247 --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=2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-27 17:25:38,443 truncating revision to first 12 chars 2016-01-27 17:25:38,443 Setting DEBUG logging. 2016-01-27 17:25:38,443 attempt 1/10 2016-01-27 17:25:38,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/24320d1e9d99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-27 17:25:38,974 unpacking tar archive at: fx-team-24320d1e9d99/testing/mozharness/ program finished with exit code 0 elapsedTime=0.802758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:39.268432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:39.268848) ========= echo 24320d1e9d99d14e391db8013e88736a6bff4247 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'24320d1e9d99d14e391db8013e88736a6bff4247'] 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=2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 24320d1e9d99d14e391db8013e88736a6bff4247 program finished with exit code 0 elapsedTime=0.004080 script_repo_revision: '24320d1e9d99d14e391db8013e88736a6bff4247' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:39.318591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:39.318912) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 17:25:39.328987) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-27 17:25:39.329396) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:25:39 INFO - MultiFileLogger online at 20160127 17:25:39 in /builds/slave/test-pgo 17:25:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:25:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:25:39 INFO - {'append_to_log': False, 17:25:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:25:39 INFO - 'blob_upload_branch': 'Fx-Team', 17:25:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:25:39 INFO - 'branch': 'Fx-Team', 17:25:39 INFO - 'buildbot_json_path': 'buildprops.json', 17:25:39 INFO - 'config_files': ('talos/linux_config.py',), 17:25:39 INFO - 'default_actions': ('clobber', 17:25:39 INFO - 'read-buildbot-config', 17:25:39 INFO - 'download-and-extract', 17:25:39 INFO - 'populate-webroot', 17:25:39 INFO - 'create-virtualenv', 17:25:39 INFO - 'install', 17:25:39 INFO - 'run-tests'), 17:25:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:25:39 INFO - 'download_minidump_stackwalk': True, 17:25:39 INFO - 'download_symbols': 'ondemand', 17:25:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:25:39 INFO - 'tooltool.py': '/tools/tooltool.py', 17:25:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:25:39 INFO - '/tools/misc-python/virtualenv.py')}, 17:25:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:25:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:25:39 INFO - 'installer_path': 'installer.exe', 17:25:39 INFO - 'log_level': 'info', 17:25:39 INFO - 'log_name': 'talos', 17:25:39 INFO - 'log_to_console': True, 17:25:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:25:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:25:39 INFO - 'opt_config_files': (), 17:25:39 INFO - 'pip_index': False, 17:25:39 INFO - 'sps_profile': False, 17:25:39 INFO - 'sps_profile_interval': 0, 17:25:39 INFO - 'suite': 'dromaeojs-e10s', 17:25:39 INFO - 'system_bits': '32', 17:25:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:25:39 INFO - 'title': 'talos-linux64-ix-012', 17:25:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:25:39 INFO - 'use_talos_json': True, 17:25:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:25:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:25:39 INFO - 'work_dir': 'build'} 17:25:39 INFO - ##### 17:25:39 INFO - ##### Running clobber step. 17:25:39 INFO - ##### 17:25:39 INFO - Running pre-action listener: _resource_record_pre_action 17:25:39 INFO - Running main action method: clobber 17:25:39 INFO - rmtree: /builds/slave/test-pgo/build 17:25:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:25:43 INFO - Running post-action listener: _resource_record_post_action 17:25:43 INFO - ##### 17:25:43 INFO - ##### Running read-buildbot-config step. 17:25:43 INFO - ##### 17:25:43 INFO - Running pre-action listener: _resource_record_pre_action 17:25:43 INFO - Running main action method: read_buildbot_config 17:25:43 INFO - Using buildbot properties: 17:25:43 INFO - { 17:25:43 INFO - "project": "", 17:25:43 INFO - "product": "firefox", 17:25:43 INFO - "script_repo_revision": "production", 17:25:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:25:43 INFO - "repository": "", 17:25:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:25:43 INFO - "buildid": "20160127143013", 17:25:43 INFO - "pgo_build": "True", 17:25:43 INFO - "basedir": "/builds/slave/test-pgo", 17:25:43 INFO - "buildnumber": 463, 17:25:43 INFO - "slavename": "talos-linux64-ix-012", 17:25:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:25:43 INFO - "platform": "ubuntu64_hw", 17:25:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:25:43 INFO - "branch": "fx-team", 17:25:43 INFO - "repo_path": "integration/fx-team", 17:25:43 INFO - "revision": "24320d1e9d99d14e391db8013e88736a6bff4247", 17:25:43 INFO - "stage_platform": "linux64-pgo", 17:25:43 INFO - "builduid": "30e3e19334674674b8ae01904cbf17ed", 17:25:43 INFO - "slavebuilddir": "test" 17:25:43 INFO - } 17:25:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:25:43 INFO - Running post-action listener: _resource_record_post_action 17:25:43 INFO - ##### 17:25:43 INFO - ##### Running download-and-extract step. 17:25:43 INFO - ##### 17:25:43 INFO - Running pre-action listener: _resource_record_pre_action 17:25:43 INFO - Running main action method: download_and_extract 17:25:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:25:43 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')]} 17:25:43 INFO - https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/test_packages.json 17:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/test_packages.json 17:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:25:44 INFO - Downloaded 1448 bytes. 17:25:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:25:44 INFO - Using the following test package requirements: 17:25:44 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:44 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:25:44 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:25:44 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:44 INFO - u'jsshell-linux-x86_64.zip'], 17:25:44 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:25:44 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:44 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:25:44 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:25:44 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:25:44 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:44 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:44 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:25:44 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:44 INFO - https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:25:45 INFO - Downloaded 22503482 bytes. 17:25:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:25:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:25:46 INFO - Return code: 0 17:25:46 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:25: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')]} 17:25:46 INFO - https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:25:47 INFO - Downloaded 22503482 bytes. 17:25:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:25:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:25:49 INFO - Return code: 0 17:25: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')]} 17:25:49 INFO - https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:25:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:25:50 INFO - Downloaded 10706572 bytes. 17:25:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:25:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:25:50 INFO - Return code: 0 17:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:50 INFO - https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:25:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:25:52 INFO - Downloaded 55979906 bytes. 17:25:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:52 INFO - mkdir: /builds/slave/test-pgo/properties 17:25:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:25:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:25:52 INFO - Contents: 17:25:52 INFO - build_url:https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:52 INFO - Running post-action listener: _resource_record_post_action 17:25:52 INFO - Running post-action listener: set_extra_try_arguments 17:25:52 INFO - ##### 17:25:52 INFO - ##### Running populate-webroot step. 17:25:52 INFO - ##### 17:25:52 INFO - Running pre-action listener: _resource_record_pre_action 17:25:52 INFO - Running main action method: populate_webroot 17:25:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:25:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:25:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:25:52 INFO - '--tppagecycles', 17:25:52 INFO - '7'], 17:25:52 INFO - 'tests': ['tsvgm']}}, 17:25:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:25:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:25:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:25:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:25:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:25:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:25:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:52 INFO - 'talos_options': ['--e10s'], 17:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:52 INFO - 'tests': ['damp', 'tps']}, 17:25:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:52 INFO - 'talos_options': ['--e10s'], 17:25:52 INFO - 'tests': ['damp', 'tps']}, 17:25:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:25:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:25:52 INFO - 'other': {'tests': ['a11yr', 17:25:52 INFO - 'ts_paint', 17:25:52 INFO - 'tpaint', 17:25:52 INFO - 'sessionrestore', 17:25:52 INFO - 'sessionrestore_no_auto_restore']}, 17:25:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:25:52 INFO - 'tests': ['a11yr', 17:25:52 INFO - 'ts_paint', 17:25:52 INFO - 'tpaint', 17:25:52 INFO - 'sessionrestore', 17:25:52 INFO - 'sessionrestore_no_auto_restore']}, 17:25:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:25:52 INFO - 'tests': ['a11yr', 17:25:52 INFO - 'ts_paint', 17:25:52 INFO - 'tpaint', 17:25:52 INFO - 'sessionrestore', 17:25:52 INFO - 'sessionrestore_no_auto_restore']}, 17:25:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:25:52 INFO - 'tests': ['a11yr', 17:25:52 INFO - 'ts_paint', 17:25:52 INFO - 'tpaint', 17:25:52 INFO - 'sessionrestore', 17:25:52 INFO - 'sessionrestore_no_auto_restore']}, 17:25:52 INFO - 'other_l64': {'tests': ['a11yr', 17:25:52 INFO - 'ts_paint', 17:25:52 INFO - 'tpaint', 17:25:52 INFO - 'sessionrestore', 17:25:52 INFO - 'sessionrestore_no_auto_restore']}, 17:25:52 INFO - 'other_nol64': {'tests': ['a11yr', 17:25:52 INFO - 'ts_paint', 17:25:52 INFO - 'tpaint', 17:25:52 INFO - 'sessionrestore', 17:25:52 INFO - 'sessionrestore_no_auto_restore']}, 17:25:52 INFO - 'svgr': {'tests': ['tsvgx', 17:25:52 INFO - 'tsvgr_opacity', 17:25:52 INFO - 'tart', 17:25:52 INFO - 'tscrollx', 17:25:52 INFO - 'cart']}, 17:25:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:25:52 INFO - 'tests': ['tsvgx', 17:25:52 INFO - 'tsvgr_opacity', 17:25:52 INFO - 'tart', 17:25:52 INFO - 'tscrollx', 17:25:52 INFO - 'cart']}, 17:25:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:52 INFO - 'tests': ['tp5o']}, 17:25:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:52 INFO - 'talos_options': ['--e10s'], 17:25:52 INFO - 'tests': ['tp5o']}, 17:25:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:52 INFO - 'talos_options': ['--xperf_path', 17:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:52 INFO - 'tests': ['tp5n']}, 17:25:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:52 INFO - 'talos_options': ['--e10s', 17:25:52 INFO - '--xperf_path', 17:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:52 INFO - 'tests': ['tp5n']}}, 17:25:52 INFO - 'talos.zip': {'path': '', 17:25:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:25:52 INFO - Running post-action listener: _resource_record_post_action 17:25:52 INFO - ##### 17:25:52 INFO - ##### Running create-virtualenv step. 17:25:52 INFO - ##### 17:25:52 INFO - Running pre-action listener: _resource_record_pre_action 17:25:52 INFO - Running main action method: create_virtualenv 17:25:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:25:52 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 17:25:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:25:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:25:52 INFO - Using real prefix '/usr' 17:25:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:25:53 INFO - Installing distribute.............................................................................................................................................................................................done. 17:25:55 INFO - Installing pip.................done. 17:25:55 INFO - Return code: 0 17:25:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:25: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')]} 17:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4be5253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2536630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7840>, '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 0x25346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', '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 17:25:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:25:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:25:55 INFO - Using env: {'DISPLAY': ':0', 17:25:55 INFO - 'HOME': '/home/cltbld', 17:25:55 INFO - 'LANG': 'en_US.UTF-8', 17:25:55 INFO - 'LANGUAGE': 'en_US:en', 17:25:55 INFO - 'LOGNAME': 'cltbld', 17:25:55 INFO - 'MAIL': '/var/mail/cltbld', 17:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:55 INFO - 'MOZ_NO_REMOTE': '1', 17:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:55 INFO - 'NO_EM_RESTART': '1', 17:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:55 INFO - 'SHELL': '/bin/bash', 17:25:55 INFO - 'SHLVL': '1', 17:25:55 INFO - 'TERM': 'linux', 17:25:55 INFO - 'TMOUT': '86400', 17:25:55 INFO - 'USER': 'cltbld', 17:25:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', 17:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:55 INFO - '_': '/tools/buildbot/bin/python'} 17:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:55 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 17:25:55 INFO - Cleaning up... 17:25:55 INFO - Return code: 0 17:25:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:25: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')]} 17:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4be5253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2536630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7840>, '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 0x25346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', '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 17:25:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:25:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:25:55 INFO - Using env: {'DISPLAY': ':0', 17:25:55 INFO - 'HOME': '/home/cltbld', 17:25:55 INFO - 'LANG': 'en_US.UTF-8', 17:25:55 INFO - 'LANGUAGE': 'en_US:en', 17:25:55 INFO - 'LOGNAME': 'cltbld', 17:25:55 INFO - 'MAIL': '/var/mail/cltbld', 17:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:55 INFO - 'MOZ_NO_REMOTE': '1', 17:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:55 INFO - 'NO_EM_RESTART': '1', 17:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:55 INFO - 'SHELL': '/bin/bash', 17:25:55 INFO - 'SHLVL': '1', 17:25:55 INFO - 'TERM': 'linux', 17:25:55 INFO - 'TMOUT': '86400', 17:25:55 INFO - 'USER': 'cltbld', 17:25:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', 17:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:55 INFO - '_': '/tools/buildbot/bin/python'} 17:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:56 INFO - Downloading/unpacking psutil>=0.7.1 17:25:56 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 17:25:56 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 17:25:56 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 17:25:56 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 17:25:56 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 17:25:56 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 17:25:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:25:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:58 INFO - Installing collected packages: psutil 17:25:58 INFO - Running setup.py install for psutil 17:25:58 INFO - building 'psutil._psutil_linux' extension 17:25:58 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 17:25:58 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 17:25:58 INFO - building 'psutil._psutil_posix' extension 17:25:58 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 17:25:59 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 17:25:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:59 INFO - Successfully installed psutil 17:25:59 INFO - Cleaning up... 17:25:59 INFO - Return code: 0 17:25:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:25: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')]} 17:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4be5253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2536630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7840>, '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 0x25346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', '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 17:25:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:25:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:25:59 INFO - Using env: {'DISPLAY': ':0', 17:25:59 INFO - 'HOME': '/home/cltbld', 17:25:59 INFO - 'LANG': 'en_US.UTF-8', 17:25:59 INFO - 'LANGUAGE': 'en_US:en', 17:25:59 INFO - 'LOGNAME': 'cltbld', 17:25:59 INFO - 'MAIL': '/var/mail/cltbld', 17:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:59 INFO - 'MOZ_NO_REMOTE': '1', 17:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:59 INFO - 'NO_EM_RESTART': '1', 17:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:59 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:59 INFO - 'SHELL': '/bin/bash', 17:25:59 INFO - 'SHLVL': '1', 17:25:59 INFO - 'TERM': 'linux', 17:25:59 INFO - 'TMOUT': '86400', 17:25:59 INFO - 'USER': 'cltbld', 17:25:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', 17:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:59 INFO - '_': '/tools/buildbot/bin/python'} 17:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:25:59 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 17:25:59 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 17:25:59 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 17:25:59 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 17:25:59 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 17:25:59 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 17:26:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:26:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:26:01 INFO - Installing collected packages: mozsystemmonitor 17:26:01 INFO - Running setup.py install for mozsystemmonitor 17:26:01 INFO - Successfully installed mozsystemmonitor 17:26:01 INFO - Cleaning up... 17:26:01 INFO - Return code: 0 17:26:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:26:01 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')]} 17:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:01 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')]} 17:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4be5253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2536630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7840>, '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 0x25346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', '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 17:26:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:26:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:26:01 INFO - Using env: {'DISPLAY': ':0', 17:26:01 INFO - 'HOME': '/home/cltbld', 17:26:01 INFO - 'LANG': 'en_US.UTF-8', 17:26:01 INFO - 'LANGUAGE': 'en_US:en', 17:26:01 INFO - 'LOGNAME': 'cltbld', 17:26:01 INFO - 'MAIL': '/var/mail/cltbld', 17:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:01 INFO - 'MOZ_NO_REMOTE': '1', 17:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:01 INFO - 'NO_EM_RESTART': '1', 17:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:01 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:01 INFO - 'SHELL': '/bin/bash', 17:26:01 INFO - 'SHLVL': '1', 17:26:01 INFO - 'TERM': 'linux', 17:26:01 INFO - 'TMOUT': '86400', 17:26:01 INFO - 'USER': 'cltbld', 17:26:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', 17:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:01 INFO - '_': '/tools/buildbot/bin/python'} 17:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:01 INFO - Downloading/unpacking blobuploader==1.2.4 17:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:26:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:26:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:26:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:26:04 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 17:26:04 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 17:26:04 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 17:26:04 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 17:26:04 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 17:26:04 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 17:26:04 INFO - Downloading docopt-0.6.1.tar.gz 17:26:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:26:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:26:04 INFO - Running setup.py install for blobuploader 17:26:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:26:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:26:04 INFO - Running setup.py install for requests 17:26:04 INFO - Running setup.py install for docopt 17:26:05 INFO - Successfully installed blobuploader requests docopt 17:26:05 INFO - Cleaning up... 17:26:05 INFO - Return code: 0 17:26:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:26:05 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')]} 17:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:05 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')]} 17:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4be5253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2536630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7840>, '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 0x25346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', '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 17:26:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:26:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:05 INFO - Using env: {'DISPLAY': ':0', 17:26:05 INFO - 'HOME': '/home/cltbld', 17:26:05 INFO - 'LANG': 'en_US.UTF-8', 17:26:05 INFO - 'LANGUAGE': 'en_US:en', 17:26:05 INFO - 'LOGNAME': 'cltbld', 17:26:05 INFO - 'MAIL': '/var/mail/cltbld', 17:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:05 INFO - 'MOZ_NO_REMOTE': '1', 17:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:05 INFO - 'NO_EM_RESTART': '1', 17:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:05 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:05 INFO - 'SHELL': '/bin/bash', 17:26:05 INFO - 'SHLVL': '1', 17:26:05 INFO - 'TERM': 'linux', 17:26:05 INFO - 'TMOUT': '86400', 17:26:05 INFO - 'USER': 'cltbld', 17:26:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', 17:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:05 INFO - '_': '/tools/buildbot/bin/python'} 17:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:26:05 INFO - Running setup.py (path:/tmp/pip-SB33nL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:26:05 INFO - Running setup.py (path:/tmp/pip-a4yxaA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:26:05 INFO - Running setup.py (path:/tmp/pip-UYyJZQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:26:05 INFO - Running setup.py (path:/tmp/pip-y0x5d5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:26:05 INFO - Running setup.py (path:/tmp/pip-ic3YBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:26:05 INFO - Running setup.py (path:/tmp/pip-QFCF9K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:26:05 INFO - Running setup.py (path:/tmp/pip-STfGNv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:26:05 INFO - Running setup.py (path:/tmp/pip-ggYfje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:26:05 INFO - Running setup.py (path:/tmp/pip-JPe78z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:26:05 INFO - Running setup.py (path:/tmp/pip-VcPpZ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:26:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:26:05 INFO - Running setup.py (path:/tmp/pip-qPx_Jc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:26:06 INFO - Running setup.py (path:/tmp/pip-auGoWr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:26:06 INFO - Running setup.py (path:/tmp/pip-j3noZI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:26:06 INFO - Running setup.py (path:/tmp/pip-mF4xrc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:26:06 INFO - Running setup.py (path:/tmp/pip-ciYMJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:26:06 INFO - Running setup.py (path:/tmp/pip-fJCxZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:26:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:26:06 INFO - Running setup.py (path:/tmp/pip-FoTkOp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:26:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:26:06 INFO - Running setup.py install for manifestparser 17:26:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:26:06 INFO - Running setup.py install for mozcrash 17:26:06 INFO - Running setup.py install for mozdebug 17:26:06 INFO - Running setup.py install for mozdevice 17:26:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:26:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:26:06 INFO - Running setup.py install for mozfile 17:26:07 INFO - Running setup.py install for mozhttpd 17:26:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Running setup.py install for mozinfo 17:26:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Running setup.py install for mozInstall 17:26:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Running setup.py install for mozleak 17:26:07 INFO - Running setup.py install for mozlog 17:26:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Running setup.py install for moznetwork 17:26:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Running setup.py install for mozprocess 17:26:07 INFO - Running setup.py install for mozprofile 17:26:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Running setup.py install for mozrunner 17:26:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:26:07 INFO - Running setup.py install for mozscreenshot 17:26:08 INFO - Running setup.py install for moztest 17:26:08 INFO - Running setup.py install for mozversion 17:26:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:26:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:26:08 INFO - Cleaning up... 17:26:08 INFO - Return code: 0 17:26:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4be5253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2536630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7840>, '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 0x25346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', '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 17:26:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:26:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:08 INFO - Using env: {'DISPLAY': ':0', 17:26:08 INFO - 'HOME': '/home/cltbld', 17:26:08 INFO - 'LANG': 'en_US.UTF-8', 17:26:08 INFO - 'LANGUAGE': 'en_US:en', 17:26:08 INFO - 'LOGNAME': 'cltbld', 17:26:08 INFO - 'MAIL': '/var/mail/cltbld', 17:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:08 INFO - 'MOZ_NO_REMOTE': '1', 17:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:08 INFO - 'NO_EM_RESTART': '1', 17:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:08 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:08 INFO - 'SHELL': '/bin/bash', 17:26:08 INFO - 'SHLVL': '1', 17:26:08 INFO - 'TERM': 'linux', 17:26:08 INFO - 'TMOUT': '86400', 17:26:08 INFO - 'USER': 'cltbld', 17:26:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', 17:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:08 INFO - '_': '/tools/buildbot/bin/python'} 17:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:26:08 INFO - Running setup.py (path:/tmp/pip-67CSb8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:26:08 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)) 17:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:26:08 INFO - Running setup.py (path:/tmp/pip-MIYNhf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:26:08 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)) 17:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:26:08 INFO - Running setup.py (path:/tmp/pip-Ey47hd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:26:08 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)) 17:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:26:08 INFO - Running setup.py (path:/tmp/pip-hFIiNG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:26:08 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)) 17:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:26:08 INFO - Running setup.py (path:/tmp/pip-voiOFD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:26:08 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)) 17:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:26:08 INFO - Running setup.py (path:/tmp/pip-SYVFIJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:26:08 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)) 17:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:26:08 INFO - Running setup.py (path:/tmp/pip-zg9eUM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:26:08 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)) 17:26:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:26:08 INFO - Running setup.py (path:/tmp/pip-65g0F_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:26:09 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)) 17:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:26:09 INFO - Running setup.py (path:/tmp/pip-QF3Uw6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:26:09 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)) 17:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:26:09 INFO - Running setup.py (path:/tmp/pip-tHBLqg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:26:09 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)) 17:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:26:09 INFO - Running setup.py (path:/tmp/pip-qHngKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:26:09 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)) 17:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:26:09 INFO - Running setup.py (path:/tmp/pip-J9gLNG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:26:09 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)) 17:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:26:09 INFO - Running setup.py (path:/tmp/pip-e33SdH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:26:09 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)) 17:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:26:09 INFO - Running setup.py (path:/tmp/pip-Py9sPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:26:09 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)) 17:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:26:09 INFO - Running setup.py (path:/tmp/pip-RTYyeB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:26:09 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)) 17:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:26:09 INFO - Running setup.py (path:/tmp/pip-VnHeCg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:26:09 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)) 17:26:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:26:09 INFO - Running setup.py (path:/tmp/pip-NL36Ql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:26:09 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)) 17:26:09 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)) 17:26:09 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)) 17:26:09 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)) 17:26:09 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)) 17:26:09 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)) 17:26:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:11 INFO - Downloading blessings-1.6.tar.gz 17:26:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:26:11 INFO - Installing collected packages: blessings 17:26:11 INFO - Running setup.py install for blessings 17:26:11 INFO - Successfully installed blessings 17:26:11 INFO - Cleaning up... 17:26:11 INFO - Return code: 0 17:26:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:26:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:26:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:26:11 INFO - Reading from file tmpfile_stdout 17:26:11 INFO - Current package versions: 17:26:11 INFO - argparse == 1.2.1 17:26:11 INFO - blessings == 1.6 17:26:11 INFO - blobuploader == 1.2.4 17:26:11 INFO - docopt == 0.6.1 17:26:11 INFO - manifestparser == 1.1 17:26:11 INFO - mozInstall == 1.12 17:26:11 INFO - mozcrash == 0.16 17:26:11 INFO - mozdebug == 0.1 17:26:11 INFO - mozdevice == 0.48 17:26:11 INFO - mozfile == 1.2 17:26:11 INFO - mozhttpd == 0.7 17:26:11 INFO - mozinfo == 0.9 17:26:11 INFO - mozleak == 0.1 17:26:11 INFO - mozlog == 3.1 17:26:11 INFO - moznetwork == 0.27 17:26:11 INFO - mozprocess == 0.22 17:26:11 INFO - mozprofile == 0.28 17:26:11 INFO - mozrunner == 6.11 17:26:11 INFO - mozscreenshot == 0.1 17:26:11 INFO - mozsystemmonitor == 0.0 17:26:11 INFO - moztest == 0.7 17:26:11 INFO - mozversion == 1.4 17:26:11 INFO - psutil == 3.1.1 17:26:11 INFO - requests == 1.2.3 17:26:11 INFO - wsgiref == 0.1.2 17:26:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:26:11 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')]} 17:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:11 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')]} 17:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4be5253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2536630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7840>, '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 0x25346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', '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 17:26:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 17:26:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:11 INFO - Using env: {'DISPLAY': ':0', 17:26:11 INFO - 'HOME': '/home/cltbld', 17:26:11 INFO - 'LANG': 'en_US.UTF-8', 17:26:11 INFO - 'LANGUAGE': 'en_US:en', 17:26:11 INFO - 'LOGNAME': 'cltbld', 17:26:11 INFO - 'MAIL': '/var/mail/cltbld', 17:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:11 INFO - 'MOZ_NO_REMOTE': '1', 17:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:11 INFO - 'NO_EM_RESTART': '1', 17:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:11 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:11 INFO - 'SHELL': '/bin/bash', 17:26:11 INFO - 'SHLVL': '1', 17:26:11 INFO - 'TERM': 'linux', 17:26:11 INFO - 'TMOUT': '86400', 17:26:11 INFO - 'USER': 'cltbld', 17:26:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', 17:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:11 INFO - '_': '/tools/buildbot/bin/python'} 17:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:12 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)) 17:26:12 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)) 17:26:12 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)) 17:26:12 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)) 17:26:12 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)) 17:26:12 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)) 17:26:12 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)) 17:26:12 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)) 17:26:12 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)) 17:26:12 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)) 17:26:12 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)) 17:26:12 INFO - Cleaning up... 17:26:12 INFO - Return code: 0 17:26:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:26: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')]} 17:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4be5253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2536630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7840>, '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 0x25346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', '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 17:26:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:26:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:26:12 INFO - Using env: {'DISPLAY': ':0', 17:26:12 INFO - 'HOME': '/home/cltbld', 17:26:12 INFO - 'LANG': 'en_US.UTF-8', 17:26:12 INFO - 'LANGUAGE': 'en_US:en', 17:26:12 INFO - 'LOGNAME': 'cltbld', 17:26:12 INFO - 'MAIL': '/var/mail/cltbld', 17:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:12 INFO - 'MOZ_NO_REMOTE': '1', 17:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:12 INFO - 'NO_EM_RESTART': '1', 17:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:12 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:12 INFO - 'SHELL': '/bin/bash', 17:26:12 INFO - 'SHLVL': '1', 17:26:12 INFO - 'TERM': 'linux', 17:26:12 INFO - 'TMOUT': '86400', 17:26:12 INFO - 'USER': 'cltbld', 17:26:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', 17:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:12 INFO - '_': '/tools/buildbot/bin/python'} 17:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:12 INFO - Downloading/unpacking jsonschema 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:26:14 INFO - Downloading/unpacking functools32 (from jsonschema) 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:14 INFO - Downloading functools32-3.2.3-2.tar.gz 17:26:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:26:14 INFO - warning: no files found matching '*.txt' 17:26:14 INFO - no previously-included directories found matching 'build' 17:26:14 INFO - no previously-included directories found matching 'dist' 17:26:14 INFO - no previously-included directories found matching '.git*' 17:26:14 INFO - Installing collected packages: jsonschema, functools32 17:26:14 INFO - Running setup.py install for functools32 17:26:14 INFO - warning: no files found matching '*.txt' 17:26:14 INFO - no previously-included directories found matching 'build' 17:26:14 INFO - no previously-included directories found matching 'dist' 17:26:14 INFO - no previously-included directories found matching '.git*' 17:26:14 INFO - Successfully installed jsonschema functools32 17:26:14 INFO - Cleaning up... 17:26:14 INFO - Return code: 0 17:26:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:26: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')]} 17:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4be5253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2536630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7840>, '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 0x25346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', '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 17:26:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 17:26:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:26:14 INFO - Using env: {'DISPLAY': ':0', 17:26:14 INFO - 'HOME': '/home/cltbld', 17:26:14 INFO - 'LANG': 'en_US.UTF-8', 17:26:14 INFO - 'LANGUAGE': 'en_US:en', 17:26:14 INFO - 'LOGNAME': 'cltbld', 17:26:14 INFO - 'MAIL': '/var/mail/cltbld', 17:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:14 INFO - 'MOZ_NO_REMOTE': '1', 17:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:14 INFO - 'NO_EM_RESTART': '1', 17:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:14 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:14 INFO - 'SHELL': '/bin/bash', 17:26:14 INFO - 'SHLVL': '1', 17:26:14 INFO - 'TERM': 'linux', 17:26:14 INFO - 'TMOUT': '86400', 17:26:14 INFO - 'USER': 'cltbld', 17:26:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', 17:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:14 INFO - '_': '/tools/buildbot/bin/python'} 17:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:14 INFO - Downloading/unpacking flake8 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:26:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:26:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:26:17 INFO - no previously-included directories found matching 'docs/_build' 17:26:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:26:17 INFO - Running setup.py install for pep8 17:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:26:17 INFO - no previously-included directories found matching 'docs/_build' 17:26:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:26:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:26:17 INFO - Cleaning up... 17:26:17 INFO - Return code: 0 17:26:17 INFO - Running post-action listener: _resource_record_post_action 17:26:17 INFO - Running post-action listener: _start_resource_monitoring 17:26:17 INFO - Starting resource monitoring. 17:26:17 INFO - ##### 17:26:17 INFO - ##### Running install step. 17:26:17 INFO - ##### 17:26:17 INFO - Running pre-action listener: _resource_record_pre_action 17:26:17 INFO - Running main action method: install 17:26:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:26:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:26:17 INFO - Reading from file tmpfile_stdout 17:26:17 INFO - Detecting whether we're running mozinstall >=1.0... 17:26:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:26:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:26:17 INFO - Reading from file tmpfile_stdout 17:26:17 INFO - Output received: 17:26:17 INFO - Usage: mozinstall [options] installer 17:26:17 INFO - Options: 17:26:17 INFO - -h, --help show this help message and exit 17:26:17 INFO - -d DEST, --destination=DEST 17:26:17 INFO - Directory to install application into. [default: 17:26:17 INFO - "/builds/slave/test-pgo"] 17:26:17 INFO - --app=APP Application being installed. [default: firefox] 17:26:17 INFO - mkdir: /builds/slave/test-pgo/build/application 17:26:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:26:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:26:33 INFO - Reading from file tmpfile_stdout 17:26:33 INFO - Output received: 17:26:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:26:33 INFO - Running post-action listener: _resource_record_post_action 17:26:33 INFO - ##### 17:26:33 INFO - ##### Running run-tests step. 17:26:33 INFO - ##### 17:26:33 INFO - Running pre-action listener: _resource_record_pre_action 17:26:33 INFO - Running main action method: run_tests 17:26:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:26:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:26:33 INFO - Python 2.7.3 17:26:33 INFO - Return code: 0 17:26:33 INFO - grabbing minidump binary from tooltool 17:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:33 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 0x25c7840>, '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 0x25346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:26:33 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 17:26:33 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 17:26:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:26:34 INFO - Return code: 0 17:26:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:26:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:26:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:26:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:26:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:26:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:26:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:26:35 INFO - Return code: 0 17:26:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 17:26:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:26:35 INFO - Using env: {'DISPLAY': ':0', 17:26:35 INFO - 'HOME': '/home/cltbld', 17:26:35 INFO - 'LANG': 'en_US.UTF-8', 17:26:35 INFO - 'LANGUAGE': 'en_US:en', 17:26:35 INFO - 'LOGNAME': 'cltbld', 17:26:35 INFO - 'MAIL': '/var/mail/cltbld', 17:26:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:26:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:35 INFO - 'MOZ_NO_REMOTE': '1', 17:26:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:35 INFO - 'NO_EM_RESTART': '1', 17:26:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:35 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:26:35 INFO - 'SHELL': '/bin/bash', 17:26:35 INFO - 'SHLVL': '1', 17:26:35 INFO - 'TERM': 'linux', 17:26:35 INFO - 'TMOUT': '86400', 17:26:35 INFO - 'USER': 'cltbld', 17:26:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501', 17:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:35 INFO - '_': '/tools/buildbot/bin/python'} 17:26:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:26:35 INFO - mozversion application_buildid: 20160127143013 17:26:35 INFO - mozversion application_changeset: 24320d1e9d99d14e391db8013e88736a6bff4247 17:26:35 INFO - mozversion application_display_name: Nightly 17:26:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:26:35 INFO - mozversion application_name: Firefox 17:26:35 INFO - mozversion application_remotingname: firefox 17:26:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:26:35 INFO - mozversion application_vendor: Mozilla 17:26:35 INFO - mozversion application_version: 47.0a1 17:26:35 INFO - mozversion platform_buildid: 20160127143013 17:26:35 INFO - mozversion platform_changeset: 24320d1e9d99d14e391db8013e88736a6bff4247 17:26:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:26:35 INFO - mozversion platform_version: 47.0a1 17:26:35 INFO - using testdate: 1453944395 17:26:35 INFO - actual date: 1453944395 17:26:35 INFO - starting webserver on 'localhost:35347' 17:26:35 INFO - SUITE-START | Running 3 tests 17:26:35 INFO - TEST-START | dromaeo_css 17:26:35 INFO - operating with platform_type : linux_ 17:26:35 INFO - Initialising browser for dromaeo_css test... 17:26:35 INFO - TEST-INFO | started process 3342 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2cBkTT/profile http://localhost:35347/getInfo.html) 17:26:40 INFO - PROCESS | 3342 | 17:26:40 INFO - PROCESS | 3342 | (process:3428): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:26:42 INFO - PROCESS | 3342 | __metrics Screen width/height:1600/1200 17:26:42 INFO - PROCESS | 3342 | colorDepth:24 17:26:42 INFO - PROCESS | 3342 | Browser inner width/height: 1024/697 17:26:42 INFO - PROCESS | 3342 | __metrics 17:26:42 INFO - PROCESS | 3342 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:26:43 INFO - TEST-INFO | 3342: exit 0 17:26:43 INFO - Browser initialized. 17:26:43 INFO - Running cycle 1/1 for dromaeo_css test... 17:26:43 INFO - TEST-INFO | started process 3477 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2cBkTT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:44 INFO - PROCESS | 3477 | 17:26:44 INFO - PROCESS | 3477 | (process:3536): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:26:55 INFO - PROCESS | 3477 | RSS: Main: 150466560 17:26:55 INFO - PROCESS | 3477 | 17:27:44 INFO - PROCESS | 3477 | 1453944464719 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] 17:29:52 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35347/tests/dromaeo/cssquery-ext.html) 17:29:53 INFO - PROCESS | 3477 | RSS: Main: 159682560 17:29:53 INFO - PROCESS | 3477 | 17:32:55 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-ext.html (next: http://localhost:35347/tests/dromaeo/cssquery-jquery.html) 17:32:56 INFO - PROCESS | 3477 | RSS: Main: 155787264 17:32:56 INFO - PROCESS | 3477 | 17:35:57 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35347/tests/dromaeo/cssquery-mootools.html) 17:35:58 INFO - PROCESS | 3477 | RSS: Main: 155607040 17:35:58 INFO - PROCESS | 3477 | 17:39:00 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35347/tests/dromaeo/cssquery-prototype.html) 17:39:00 INFO - PROCESS | 3477 | RSS: Main: 155189248 17:39:00 INFO - PROCESS | 3477 | 17:42:03 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35347/tests/dromaeo/cssquery-yui.html) 17:42:03 INFO - PROCESS | 3477 | RSS: Main: 155639808 17:42:03 INFO - PROCESS | 3477 | 17:45:06 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-yui.html (next: http://localhost:35347/tests/dromaeo/cssquery-dojo.html) 17:45:06 INFO - PROCESS | 3477 | RSS: Main: 157712384 17:45:06 INFO - PROCESS | 3477 | 17:45:06 INFO - PROCESS | 3477 | __start_tp_report 17:45:06 INFO - PROCESS | 3477 | _x_x_mozilla_page_load 17:45:06 INFO - PROCESS | 3477 | _x_x_mozilla_page_load_details 17:45:06 INFO - PROCESS | 3477 | |i|pagename|runs| 17:45:06 INFO - PROCESS | 3477 | |0;dojo.html;3189.760767942404;3191.0267368452614;3227.3867965086647;3235.3529294141163;3243.172990887324;5172.45689202633;5196.662216955895;5197.1944348625975;5199.948000519994;5297;5141.305923700299;5182.481751824816;5192.766325515351;5244.475552444754;5321.547668448186;4651.162790697673;4719.339292499053;4766.189747742875;4812.639052071091;4812.903741925159;412.60245089121213;4708.176069187895;4818.855434336975;4858.368412106439;4865.318855360252;4671.462781780105;4812.566868981791;4842.4189097308545;4846.442659094214;4850.6362022848425;4843.15244832153;4844.2733589961435;4850.029994001214;4879.682820616684;4903.803847846082;4740.241561350167;4812;4812.230043193107;4842.104210720992;4843.612510999147;5003.724050367133;5043.773030213649;5055.898882022376;5096.61775366849;5155.871103222412;5555.527780138693;5668.744906479218;5675.1770993205755;5675.886482270332;5720.656760594377;5462.590305727086;5548.389677135512;5691.630044047124;5724.169995350692;5746.626469279484;5221.112410890158;5245.527902488756;5248.343957005412;5250.159974404077;5282.286891269668;5647.350554686182;5689.203511508392;5698.145278208219;5703.144528320785;5748.9425105748405;5399.919001214985;5418.972905135449;5436.939796739598;5443.156310771837;5529.695866727368;5631.465010823965;5633.859153521113;5634.464725851038;5641.9435805641415;5677.205191273225;5568.303962004749;5594.216809646653;5615.157726341;5623.409541998031;5639.013172694762;5540.667559946416;5574.693391863487;5590.888182236333;5598.58010649203;5672.943270567324;4368.475782906072;4371.78141092944;4394.099209662011;4397.670174736908;4436.511983681792;3877.0888841122314;3926.3521518949624;3926.725129240983;3968.861089861841;3980.144268982183;5050.646454748133;5104.795808167706;5116.539511443988;5120.667156634807;5138.58891288696;5417.052015897202;5465.371482279589;5472;5472.343318801769;5478.91781623276;5077.644564880423;5124.641275110706;5132.615053870974;5158.38099428071;5167.173252279617;4698.3187437821325;4710.24636058229;4722.905541889143;4767.046590681877;4812.06164797868;5757.453041961007;5763.0202865512965;5788.942110578924;5815.854603634943;5816.70916454184;5586.050371436947;5599.972000139973;5605.32736071674;5606.271184745957;5611.5230205433;5625.09998400254;5654.802081927113;5741.827745167485;5746.741396637078;5797.623154494944;5421.674699518042;5469.343678758574;5470.480304371078;5471.151971444432;5500.724963751716;5526.41972592888;5557.305336832896;5575.888482230252;5576.10782274834;5642.435756424489;5380.677159370451;5427.810026649048;5436.40199578054;5527.640703354269;5613.24221230145;5495.313085864267;5521.585881058856;5537.916931246115;5540.030494663499;5545.140503222007;5381.058314794817;5442.319710036246;5443.183522471661;5450.91823622638;5503;5320.813771517978;5383.488568585978;5460.863478413072;5559.916601251065;5588.2455868458865;5381.623286370073;5383.650062745909;5427.6200665953;5428.07722687152;5428.267183930119 17:45:06 INFO - PROCESS | 3477 | |1;ext.html;508.0524821208445;545.9563234941205;552.0945649135418;559.8992181407345;564.4045531963778;35061.64938350622;35135;35679;35693.82153089234;35773.284534309365;39351.80324098383;39664.405033924515;39782.40326395106;39801.40297895534;40055.59944400555;8476.15238476152;8588.484690918534;8644.351673624471;8664.696735614254;8672.306215502776;8365.539895305787;8513.233808957193;8518.148185181495;8742.606582703762;8751;8695;8750.737477875675;8778.60496277669;8784.209421152094;8792.47245165289;8637.222649961503;8676.392652514327;8696.521691306976;8712.303015758756;8742;8542.87185692209;8662.09048049952;8670.306375489945;8677.826443471095;8722.34582406322;39833;39882.60117398818;40014.599854001375;40273.59726402728;40335.596644033474;3162.3359094589932;3193.3913439680687;3289.523019162208;3301.8209377929393;3953.4267531207815;28787.136385908456;29119.708802912122;29683.257918552208;29723.554146687817;29767.25581860449;3355.1782345347833;3383.695467407945;3440.2947395783804;3491.0574144980715;3497.91255218619;255299;257712;258189;258416;258478;51552.22671659928;52531.21203181955;55972.16041759377;58518.41481585215;59461.405385946455;52604.47395526072;52635.210471842955;52854;52862;53056;16005.679886402208;16029.67940641204;16162.111083890264;16261.918690406472;16339.754903676454;11745.530178792924;11745.765084698429;11825.586104486301;11850.170488065753;11867.465964031639;19264.711029334572;19539.072160835913;19602.21591136367;19635.31276405319;19707.704384434244;7323;7349.522281051714;7350.742724004741;7380.741674041383;7430.331270185601;863.8747381629629;887.5784002598714;1013.0730381700808;1047.8009178256107;1103.906167975715;28180.43639127206;28334.149975500768;29846.25384365408;30802.229944251125;31488.212794679857;981.5828272983953;988.2983082011708;992.8709267795141;1058.7406085509099;1108.2906939558688;12065.155439119353;12482.937585312015;12536.686582835502;12593.181443206346;12672.303023333805;335645;335911;336311;340071;341070;44672.77663611726;44682.10635787331;44899;45215.77392113018;45623;1348.6560926963757;1367.3710093357167;1377.5591810620506;1384.1418320641267;1386.0574809129687;23120.306390808302;23921;29070.27324316909;31332.373352532366;31375.21561960969;47027;47327.29009064936;47438.28842567295;47608.52391476041;47650.285245722036;255326;255432;256355;256492;257371;31238;32178;32452.675473244966;32604.673953260164;32656.51015234726;41001;41862.79068604638;43346.34980475358;43463.130737385705;44249.11501770011;32344.259285902062;34671.65328346684;35110.64889351176;35715.28569428545;35801;34376;35539.11152221215;36099.458508121876;36314.092147696516;39414.605853941095;33010.83494582512;33039;33171.83414082914;33367.665293387996;33602.32795344129;31030.53454198234;31708.207294817814;32147.51778723368;32433.837830810695;32521.512177317833;23306.184283549996;23792.88103559471;23971.28086157418;24199.395015124057;24221.51556968886 17:45:06 INFO - PROCESS | 3477 | |2;jquery.html;363.06329669452816;363.99454008189883;366.53816191598577;367.80322527447805;368.2469350178883;15339;16617.50147495574;16873.156342182872;17519.73720394192;17717.911410442946;11055.72360690983;11260.605878794244;16428.83571164288;16528.83471165291;16594.66810663786;4878.78045487953;5458.972705136469;5459.590530710193;5462.071447853855;5520.613557051008;5281.287026251464;5360.865978350553;5425.321834770653;5437.211604317372;5494.560435165177;4869.902601947977;5005.124103281929;5410.675359478424;5462.754176062067;5468.781248750065;4937.136001199776;4959.454460009396;4970.080535100999;5006.674566153189;5030.974845125769;5073.34046573943;5080.720560369178;5088.796448142107;5089.083964886319;5089.592832573422;12178;14632.487862924747;19027.334043308558;19653.60692786136;19681.40955771329;2015.9294424695213;2021.4744166516664;2036.3483685220735;2048.4878780304775;2142.8500004999655;9277.396969196981;9487.193588544982;9543.188828949547;9588.856167157499;11089.445527723581;1595.7606359046235;1664.1263336748184;1718.510224585987;1823.6990896502061;1862.0596598717696;54187.458125418634;55177.72411137959;55748.44251557514;57309.26556093087;57466.42533574653;9746.220302375792;10051.547680354402;10121.139703125169;10179.338343007681;10203.979602039737;13015.479380824661;13189.538366157138;13213.669658258621;13213.73572528544;13236.272005039622;7718.266764657348;7723.613819309125;7746.109197442253;7804.843903121906;7805.453618246782;7530.359919406912;7569.810754731176;7570.318671319607;7608.277213664693;7644.159142494321;4376.277914144131;4400.735955842596;4423.07115505741;4425.933610995773;4431.468223813163;1831.3224107080466;1846.7876194237836;1860.3209828412532;1881.9529511762316;1904.9238030478625;416.40662056569266;422.6618705035959;434.07975092803457;442.8317239448989;457.40994117588605;9645.807083858284;10045.497725113715;10283.382997020202;10311.07200351972;10348.016938390841;452.19509273492577;453.46491140453924;463.59203900567957;467.2057502246195;488.2310361181154;5445.673259604437;5568.972155139199;5572.3034620672415;5654.6324488908085;5899.085641725539;352736;357788;362238;505613;511137;67939.32060679428;72661;73113.6344318275;74269.6286518564;74639.62680186564;1141.5262665993519;1170.0639488409238;1170.9648710538697;1172.3200543684643;1191.2911817468419;14769.778453322993;14824.407023719363;14846.099635721146;14895.553133406016;15037.849621504083;29453.26366840846;29843.253918652208;29876;30363.84818075984;31310.530342044432;36323;39410.40884386679;39566;40891.59108408878;41561.79219104006;2863.0838131797623;2881.0924558763923;5963.13534537481;6967.372936435745;7142.714291428285;10263.12763415118;10676.62631807883;10730.248882578144;11666.533338666359;11834.704132396415;7346.595937223504;8522.616482258189;8812.734381233677;9203.40177888435;9581.616735330508;9834.164096051916;9858.457784821903;9909.554070067008;10004;10211;6477.287498375081;6911.827204319932;7020.894686579603;7316.743913963199;9310.674126405544;9243.701653890219;10027.749306267402;10333.638322658671;10357.792844143225;10515.106215971728;9470.289728270269;9553.904460955302;9557.761055973657;9701.17540009079;9761.707148785548 17:45:06 INFO - PROCESS | 3477 | |3;mootools.html;1475.4909556203108;1519.6504803895107;1674.8995060296384;1772.5745821002963;1796.838284554389;7664.11862635797;7782.8443431131345;7856.332211762007;8026.959865200673;8030.91969080309;7762.883556746653;7835.177306382833;7882.369410447165;7926.92073079269;7944.563049032301;2293.9541209175804;2334.719833619968;2337.567550003255;2339.777721116491;2347.4718188407555;2298.9540209195807;2325.3256555598855;2332.067173130753;2336.3575016870413;2338.7427382987858;2289.3589794857467;2297.115610489965;2318.107528601484;2329.440934175794;2345.2377977157407;2278.840481166319;2289.404754763765;2303.7696230376914;2307.7922986931258;2311.318161142467;2254.842161048727;2315.0623997281127;2321.257197696738;2323.0591610397814;2329.312852708455;7804.297613214781;7953.403494737918;7959.482633628795;7995.040595128622;8023.117457079717;4740.834070807505;4765.642576806718;4822.831200907952;4837.8306759263605;4847.175980083359;3021;3038.559408885699;3058.235441139715;3080.645725741546;3085.3520760640295;955.6177528988391;955.8948515663271;962.3311798300184;970.6214576315243;1003.3428104591504;11001.779964400746;11052.889471105267;11100.056495197838;11110.44447777616;11119.221654484189;4084.3873418986796;4093.9795301023305;4170.22850772608;4180.226658068206;4195.958040419557;9064.456132632064;9074.546272686339;9086.81826363469;9089.09109089099;9102.86345704815;4796.904061918742;4798.088363210979;4812.807487700523;4826.300186473012;4840.128776820206;4393.626541743924;4399.6040356368085;4419.867403977822;4421.204183246982;4433.290673492225;3405.233822389992;3465.774724642941;3466.7573269871373;3485.006773069663;3502.264524449843;1023.2683631203726;1044.6865940217904;1057.1595581512563;1061.5806756331206;1063.9148868090533;1033.379972016799;1035.99482002591;1066.5520481397832;1163.743976325207;1252.7619752247044;7338.816529586803;7392.963035184897;7407.592582407911;7413.88879166813;7440.627968601549;1067.5836423794726;1092.5302120088438;1096.1011970184372;1105.4693747001484;1115.297362661518;5698.031334673115;5744.798932037442;5772.624779389326;5788.044972579477;5806.303243610793;9276.35065545419;9428;9693.660721874701;9753.804923901482;9789.412635241908;9622.37454565465;9641.903580964101;9642.951785241028;9668.70993870185;9693.70918872435;7495.8500829983095;7515.098188217449;7562.697492100365;7611.2769286917655;7641.885371719429;7260;7308.488405811755;7314.4514161439165;7318.853622927618;7378.5941773202985;8375.748727538183;8435.409521333448;8658.220760131366;8719.738407847775;8734.73795786102;8824.86762698573;8911.73264802057;8932.374733768835;8945.821083578423;8958.82082358336;6753.561018533779;6878.933765266392;6903.827404314932;6948.200956890022;6953.096097507291;7566.886496702444;7596.240375962359;7617;7634.045744281965;7658.042744656918;6934.791956241321;7044.119485064367;7059.082319298664;7118.359347658736;7220.783376498714;6301.936980630135;6670;6671.33286671329;6724.125863637696;6902.413294869993;6718.059471674067;6726.495512836459;6735.764248251287;6763.458923286224;6806.591604503746;6357.90463143044;6368.617882927039;6441.967790161207;6494.935050649433;6542.640154791342;6586.077949087227;6626.536142470173;6630.569013014138;6637.2699003108655;6666.466682665472 17:45:06 INFO - PROCESS | 3477 | |4;prototype.html;308.92740206051576;317.6394791911181;319.9360127974404;320.8844815866289;323.2887647176213;6130.448259656636;6257.155284036654;6357.682115894204;6394.680265986705;6403.167588213531;6182.876342473159;6194.4115309045565;6196.845078873031;6240.157578726882;6261.060840873871;4584.106099310636;4684.180268453024;4690.671652984292;4760.143174228638;4768.904621907551;4700.130475861959;4716.929246061295;4723;4726.574608285254;4744.027474367764;4675.789589468465;4685.9062818743605;4686.08621318843;4690.273007683814;4695.131400690866;4679.532046795311;4687.789049492781;4695.389599352079;4696.483386827446;4706.929396059062;3966.5835087315995;4074.449949256842;4097.85657501986;4103.651189648884;4103.835846566134;5787.623804452739;5838.970805145947;5871.207387002785;5896.941030589682;5904.557158213108;5393.325834270716;5393.78424863005;5407.756650950717;5413.26920865682;5439.782408703687;6439.967800161016;6493.642849643268;6498.772542960974;6509.218893732735;6513.088167656484;4329.675274354436;4404.295312749945;4405.207062728708;4427.247367947424;4465.151621191963;6758.155230596176;6823.829404264883;6842.7605033824075;6848.315168483112;6860.588364698084;4525.886852828706;4531.252343363308;4533.32000199966;4540.977295113569;4574.08518296342;4521.977390113094;4569.223232050559;4581.060882519142;4590.472095708969;4606.124836281096;5385.515303622615;5442.809501667422;5456.099743542351;5462.153366228241;5465.262189604353;6573.441257493167;6580.539362244597;6594.670266486656;6597.670116494156;6606.966965165239;1633.86112180466;1636.0674415583003;1637.8607818335336;1642.6386195037073;1643.3837311008372;1091.4651820607844;1111.4442778610694;1117.7987962166887;1128.9435528223555;1131.536070211226;6202.0696895465135;6262.530310226751;6265.561410701298;6267.4986001119805;6305.747770089237;6849.1438570178725;6863.553868998499;6870.141232345957;6908.0674108995645;6908.861822763617;6243.094751261133;6248.375162483806;6287.559870808999;6294.307626161119;6295.496360291166;3627.8730244441317;3707.8320329096787;3719.814009299524;3736.9813150934615;3748.4002559590335;7093.113360829896;7100.964495177491;7106;7106.5736055836815;7111.4666400020205;6972.407345375598;6980.232174460805;7017.087778588853;7033.542819716702;7050.506464547535;6881.41507971818;7064.894026589605;7083.433325333961;7087.92912070883;7129.2870712929325;6812.557183783038;6823.727050917908;6833.726650933907;6839.760608378683;6884.311568843075;6743.35938085881;6750.1562304711915;6797.830054248683;6798.898016529657;6807.625580593115;6914.377706006484;7070.71717131309;7076.080109585927;7079.539829911039;7085.893711594434;4648.047150334241;4684;4697.177993851131;4698.224792909132;4712.458067322302;6799.490038247052;6812.829679258059;6865.450763938773;6878.793636190922;6883.7590684325805;6408.39120283591;6581.9670901647105;6673.766418175341;6683.131192944886;6702.899456508254;6635.502337324817;6651.50113741481;6664.400203981665;6669;6690.899636505554;6492.091107244895;6498.967505162444;6517.543771936109;6543.051257567721;6562.901556476752;6496.9025464617125;6613.900791488035;6676.766313179015;6696.83257918556;6708.463322934251;6449.871002580016;6487.837804054936;6536.3136870627895;6544.149260596092;6561.1470508833545 17:45:06 INFO - PROCESS | 3477 | |5;yui.html;706.0679902528664;714.6569646569646;796.474326944217;796.9521828690278;804.5896592737702;13067.673308167301;13176.1435506692;13250.07249492536;13291.534796282132;13338.733225335487;12644.241345519275;12657.430415631296;12657.936710316435;12723.872761272385;12742.936285318561;768.7693691892438;798.2496453333877;813.2071230550225;820.8399362124359;822.2065706593137;809.4010432280099;811.736185739634;814.1532805881906;814.698561532234;816.2042009041168;846.2806614377791;846.7713717296326;851.1445996773234;853.3343991686495;854.786303424144;831.0484495252932;838.4214891724721;843.9451435656663;846.7544412120478;849.2611428057629;632.0582332324849;632.4876849751715;634.2199095112991;635.5297080160694;636.0268788753169;13667.453301867914;13833.723325533432;13851.376688049062;13881.167129972133;13893.374798134108;12204.816927746091;12240.326782026985;12500.062495312797;12714.554990575285;12953.093283470162;10149.441780702058;10252.436116013616;10451.11165550929;10493.265471417004;10532.94733526335;4299.527052024275;4314.654827613784;4330.437043184397;4428.136513379892;4434.091011342667;46954.76522617399;47617.04765904697;47619;47624;47730.28404573934;9324.393914395543;9730.513474326255;9733.2213422926;10066.641003464585;10159.288849780592;16070.919645401698;16086.43697470583;16221.188940552925;16288.837111628969;16298.837011629968;7546.924530754732;7768.378529717722;7774.766756997299;7797.220277972157;7822.921770782333;4065.9796701016307;4081.9387709184384;4098.180363927227;4108.968777211096;4116.4648595682365;2991.880324786984;3059.0975662179267;3066.0955018269665;3071.6467606225124;3080.7843450958217;566.64301490061;570;570.0793218951446;575.9971200144056;577.0075470191264;638.664701031962;642.2132887213127;658.5764387055585;665.3346653346654;681.8806708825936;7867.370610351159;7983.321417679563;7998.520088794691;7999.440039197317;8212.63043163059;516.0478916399237;548.6104865545508;548.975296111668;625.1716475669756;660.7885476647426;3893.6301051400073;3894.902627434337;3967.92064158721;4018.578049304839;4181.498220213593;53224.46775532195;54061;54395.184072238946;54427.9179061572;54484.72757636266;48670;49028;49349.25976110361;50075.9984800302;50514.494855051715;44454.55545444569;45094;45353.65048893158;45534.772326138154;46121.769391152826;8571.914280857112;8651.221390074923;8849.159329863653;8983.326250531105;9026.45841249527;31965.520517192726;32670.83664581662;32890.83554582212;32896.83551582227;34674.306513870084;43165;43268.35097473604;43352.349714754935;43668.56331436645;43794.56205437905;11583.76832463363;11632.76734465289;11692.181547291608;11863.881361186277;11887.405629718653;12439.37803109859;12444.688882778002;12466.56205634006;12572.1199516033;12596.370181491073;11112.277701949348;11117.388543630179;11322.60370887015;11596.536138554364;11796.29222246668;10778.568857245937;11199.216054876406;11302.095832333558;11522.596709115141;11590.826137608112;10948.288361256493;11169.609063682732;11249.268797528135;11659.53361865516;11741;10004.149647279772;10017.59929602837;10037.34757240777;10198.3339355451;10373.585056597953;9255.444673319622;9410.200132988499;9921.950390248003;9952.694230894138;10035.799284014132 17:45:06 INFO - PROCESS | 3477 | __end_tp_report 17:45:06 INFO - PROCESS | 3477 | __start_cc_report 17:45:06 INFO - PROCESS | 3477 | _x_x_mozilla_cycle_collect,306 17:45:06 INFO - PROCESS | 3477 | __end_cc_report 17:45:06 INFO - PROCESS | 3477 | __startTimestamp1453945506683__endTimestamp 17:45:06 INFO - PROCESS | 3477 | 17:45:06 INFO - PROCESS | 3477 | ------- Summary: start ------- 17:45:06 INFO - PROCESS | 3477 | Number of tests: 6 17:45:06 INFO - PROCESS | 3477 | 17:45:06 INFO - PROCESS | 3477 | [#0] dojo.html Cycles:165 Average:5171.34 Median:5417.05 stddev:663.33 (12.2%) stddev-sans-first:646.89 17:45:06 INFO - PROCESS | 3477 | Values: 3189.8 3191.0 3227.4 3235.4 3243.2 5172.5 5196.7 5197.2 5199.9 5297.0 5141.3 5182.5 5192.8 5244.5 5321.5 4651.2 4719.3 4766.2 4812.6 4812.9 412.6 4708.2 4818.9 4858.4 4865.3 4671.5 4812.6 4842.4 4846.4 4850.6 4843.2 4844.3 4850.0 4879.7 4903.8 4740.2 4812.0 4812.2 4842.1 4843.6 5003.7 5043.8 5055.9 5096.6 5155.9 5555.5 5668.7 5675.2 5675.9 5720.7 5462.6 5548.4 5691.6 5724.2 5746.6 5221.1 5245.5 5248.3 5250.2 5282.3 5647.4 5689.2 5698.1 5703.1 5748.9 5399.9 5419.0 5436.9 5443.2 5529.7 5631.5 5633.9 5634.5 5641.9 5677.2 5568.3 5594.2 5615.2 5623.4 5639.0 5540.7 5574.7 5590.9 5598.6 5672.9 4368.5 4371.8 4394.1 4397.7 4436.5 3877.1 3926.4 3926.7 3968.9 3980.1 5050.6 5104.8 5116.5 5120.7 5138.6 5417.1 5465.4 5472.0 5472.3 5478.9 5077.6 5124.6 5132.6 5158.4 5167.2 4698.3 4710.2 4722.9 4767.0 4812.1 5757.5 5763.0 5788.9 5815.9 5816.7 5586.1 5600.0 5605.3 5606.3 5611.5 5625.1 5654.8 5741.8 5746.7 5797.6 5421.7 5469.3 5470.5 5471.2 5500.7 5526.4 5557.3 5575.9 5576.1 5642.4 5380.7 5427.8 5436.4 5527.6 5613.2 5495.3 5521.6 5537.9 5540.0 5545.1 5381.1 5442.3 5443.2 5450.9 5503.0 5320.8 5383.5 5460.9 5559.9 5588.2 5381.6 5383.7 5427.6 5428.1 5428.3 17:45:06 INFO - PROCESS | 3477 | 17:45:06 INFO - PROCESS | 3477 | [#1] ext.html Cycles:180 Average:44755.97 Median:3494.48 stddev:74864.21 (2142.4%) stddev-sans-first:75000.51 17:45:06 INFO - PROCESS | 3477 | Values: 508.1 546.0 552.1 559.9 564.4 35061.6 35135.0 35679.0 35693.8 35773.3 39351.8 39664.4 39782.4 39801.4 40055.6 8476.2 8588.5 8644.4 8664.7 8672.3 8365.5 8513.2 8518.1 8742.6 8751.0 8695.0 8750.7 8778.6 8784.2 8792.5 8637.2 8676.4 8696.5 8712.3 8742.0 8542.9 8662.1 8670.3 8677.8 8722.3 39833.0 39882.6 40014.6 40273.6 40335.6 3162.3 3193.4 3289.5 3301.8 3953.4 28787.1 29119.7 29683.3 29723.6 29767.3 3355.2 3383.7 3440.3 3491.1 3497.9 255299.0 257712.0 258189.0 258416.0 258478.0 51552.2 52531.2 55972.2 58518.4 59461.4 52604.5 52635.2 52854.0 52862.0 53056.0 16005.7 16029.7 16162.1 16261.9 16339.8 11745.5 11745.8 11825.6 11850.2 11867.5 19264.7 19539.1 19602.2 19635.3 19707.7 7323.0 7349.5 7350.7 7380.7 7430.3 863.9 887.6 1013.1 1047.8 1103.9 28180.4 28334.1 29846.3 30802.2 31488.2 981.6 988.3 992.9 1058.7 1108.3 12065.2 12482.9 12536.7 12593.2 12672.3 335645.0 335911.0 336311.0 340071.0 341070.0 44672.8 44682.1 44899.0 45215.8 45623.0 1348.7 1367.4 1377.6 1384.1 1386.1 23120.3 23921.0 29070.3 31332.4 31375.2 47027.0 47327.3 47438.3 47608.5 47650.3 255326.0 255432.0 256355.0 256492.0 257371.0 31238.0 32178.0 32452.7 32604.7 32656.5 41001.0 41862.8 43346.3 43463.1 44249.1 32344.3 34671.7 35110.6 35715.3 35801.0 34376.0 35539.1 36099.5 36314.1 39414.6 33010.8 33039.0 33171.8 33367.7 33602.3 31030.5 31708.2 32147.5 32433.8 32521.5 23306.2 23792.9 23971.3 24199.4 24221.5 17:45:06 INFO - PROCESS | 3477 | 17:45:06 INFO - PROCESS | 3477 | [#2] jquery.html Cycles:180 Average:23441.12 Median:2432.95 stddev:69635.15 (2862.2%) stddev-sans-first:69808.94 17:45:06 INFO - PROCESS | 3477 | Values: 363.1 364.0 366.5 367.8 368.2 15339.0 16617.5 16873.2 17519.7 17717.9 11055.7 11260.6 16428.8 16528.8 16594.7 4878.8 5459.0 5459.6 5462.1 5520.6 5281.3 5360.9 5425.3 5437.2 5494.6 4869.9 5005.1 5410.7 5462.8 5468.8 4937.1 4959.5 4970.1 5006.7 5031.0 5073.3 5080.7 5088.8 5089.1 5089.6 12178.0 14632.5 19027.3 19653.6 19681.4 2015.9 2021.5 2036.3 2048.5 2142.9 9277.4 9487.2 9543.2 9588.9 11089.4 1595.8 1664.1 1718.5 1823.7 1862.1 54187.5 55177.7 55748.4 57309.3 57466.4 9746.2 10051.5 10121.1 10179.3 10204.0 13015.5 13189.5 13213.7 13213.7 13236.3 7718.3 7723.6 7746.1 7804.8 7805.5 7530.4 7569.8 7570.3 7608.3 7644.2 4376.3 4400.7 4423.1 4425.9 4431.5 1831.3 1846.8 1860.3 1882.0 1904.9 416.4 422.7 434.1 442.8 457.4 9645.8 10045.5 10283.4 10311.1 10348.0 452.2 453.5 463.6 467.2 488.2 5445.7 5569.0 5572.3 5654.6 5899.1 352736.0 357788.0 362238.0 505613.0 511137.0 67939.3 72661.0 73113.6 74269.6 74639.6 1141.5 1170.1 1171.0 1172.3 1191.3 14769.8 14824.4 14846.1 14895.6 15037.8 29453.3 29843.3 29876.0 30363.8 31310.5 36323.0 39410.4 39566.0 40891.6 41561.8 2863.1 2881.1 5963.1 6967.4 7142.7 10263.1 10676.6 10730.2 11666.5 11834.7 7346.6 8522.6 8812.7 9203.4 9581.6 9834.2 9858.5 9909.6 10004.0 10211.0 6477.3 6911.8 7020.9 7316.7 9310.7 9243.7 10027.7 10333.6 10357.8 10515.1 9470.3 9553.9 9557.8 9701.2 9761.7 17:45:06 INFO - PROCESS | 3477 | 17:45:06 INFO - PROCESS | 3477 | [#3] mootools.html Cycles:180 Average:5523.25 Median:6518.79 stddev:2896.16 (44.4%) stddev-sans-first:2888.30 17:45:06 INFO - PROCESS | 3477 | Values: 1475.5 1519.7 1674.9 1772.6 1796.8 7664.1 7782.8 7856.3 8027.0 8030.9 7762.9 7835.2 7882.4 7926.9 7944.6 2294.0 2334.7 2337.6 2339.8 2347.5 2299.0 2325.3 2332.1 2336.4 2338.7 2289.4 2297.1 2318.1 2329.4 2345.2 2278.8 2289.4 2303.8 2307.8 2311.3 2254.8 2315.1 2321.3 2323.1 2329.3 7804.3 7953.4 7959.5 7995.0 8023.1 4740.8 4765.6 4822.8 4837.8 4847.2 3021.0 3038.6 3058.2 3080.6 3085.4 955.6 955.9 962.3 970.6 1003.3 11001.8 11052.9 11100.1 11110.4 11119.2 4084.4 4094.0 4170.2 4180.2 4196.0 9064.5 9074.5 9086.8 9089.1 9102.9 4796.9 4798.1 4812.8 4826.3 4840.1 4393.6 4399.6 4419.9 4421.2 4433.3 3405.2 3465.8 3466.8 3485.0 3502.3 1023.3 1044.7 1057.2 1061.6 1063.9 1033.4 1036.0 1066.6 1163.7 1252.8 7338.8 7393.0 7407.6 7413.9 7440.6 1067.6 1092.5 1096.1 1105.5 1115.3 5698.0 5744.8 5772.6 5788.0 5806.3 9276.4 9428.0 9693.7 9753.8 9789.4 9622.4 9641.9 9643.0 9668.7 9693.7 7495.9 7515.1 7562.7 7611.3 7641.9 7260.0 7308.5 7314.5 7318.9 7378.6 8375.7 8435.4 8658.2 8719.7 8734.7 8824.9 8911.7 8932.4 8945.8 8958.8 6753.6 6878.9 6903.8 6948.2 6953.1 7566.9 7596.2 7617.0 7634.0 7658.0 6934.8 7044.1 7059.1 7118.4 7220.8 6301.9 6670.0 6671.3 6724.1 6902.4 6718.1 6726.5 6735.8 6763.5 6806.6 6357.9 6368.6 6442.0 6494.9 6542.6 6586.1 6626.5 6630.6 6637.3 6666.5 17:45:06 INFO - PROCESS | 3477 | 17:45:06 INFO - PROCESS | 3477 | [#4] prototype.html Cycles:180 Average:5501.19 Median:6264.05 stddev:1685.17 (26.9%) stddev-sans-first:1644.22 17:45:06 INFO - PROCESS | 3477 | Values: 308.9 317.6 319.9 320.9 323.3 6130.4 6257.2 6357.7 6394.7 6403.2 6182.9 6194.4 6196.8 6240.2 6261.1 4584.1 4684.2 4690.7 4760.1 4768.9 4700.1 4716.9 4723.0 4726.6 4744.0 4675.8 4685.9 4686.1 4690.3 4695.1 4679.5 4687.8 4695.4 4696.5 4706.9 3966.6 4074.4 4097.9 4103.7 4103.8 5787.6 5839.0 5871.2 5896.9 5904.6 5393.3 5393.8 5407.8 5413.3 5439.8 6440.0 6493.6 6498.8 6509.2 6513.1 4329.7 4404.3 4405.2 4427.2 4465.2 6758.2 6823.8 6842.8 6848.3 6860.6 4525.9 4531.3 4533.3 4541.0 4574.1 4522.0 4569.2 4581.1 4590.5 4606.1 5385.5 5442.8 5456.1 5462.2 5465.3 6573.4 6580.5 6594.7 6597.7 6607.0 1633.9 1636.1 1637.9 1642.6 1643.4 1091.5 1111.4 1117.8 1128.9 1131.5 6202.1 6262.5 6265.6 6267.5 6305.7 6849.1 6863.6 6870.1 6908.1 6908.9 6243.1 6248.4 6287.6 6294.3 6295.5 3627.9 3707.8 3719.8 3737.0 3748.4 7093.1 7101.0 7106.0 7106.6 7111.5 6972.4 6980.2 7017.1 7033.5 7050.5 6881.4 7064.9 7083.4 7087.9 7129.3 6812.6 6823.7 6833.7 6839.8 6884.3 6743.4 6750.2 6797.8 6798.9 6807.6 6914.4 7070.7 7076.1 7079.5 7085.9 4648.0 4684.0 4697.2 4698.2 4712.5 6799.5 6812.8 6865.5 6878.8 6883.8 6408.4 6582.0 6673.8 6683.1 6702.9 6635.5 6651.5 6664.4 6669.0 6690.9 6492.1 6499.0 6517.5 6543.1 6562.9 6496.9 6613.9 6676.8 6696.8 6708.5 6449.9 6487.8 6536.3 6544.1 6561.1 17:45:06 INFO - PROCESS | 3477 | 17:45:06 INFO - PROCESS | 3477 | [#5] yui.html Cycles:180 Average:13507.05 Median:24111.35 stddev:15317.13 (63.5%) stddev-sans-first:15329.93 17:45:06 INFO - PROCESS | 3477 | Values: 706.1 714.7 796.5 797.0 804.6 13067.7 13176.1 13250.1 13291.5 13338.7 12644.2 12657.4 12657.9 12723.9 12742.9 768.8 798.2 813.2 820.8 822.2 809.4 811.7 814.2 814.7 816.2 846.3 846.8 851.1 853.3 854.8 831.0 838.4 843.9 846.8 849.3 632.1 632.5 634.2 635.5 636.0 13667.5 13833.7 13851.4 13881.2 13893.4 12204.8 12240.3 12500.1 12714.6 12953.1 10149.4 10252.4 10451.1 10493.3 10532.9 4299.5 4314.7 4330.4 4428.1 4434.1 46954.8 47617.0 47619.0 47624.0 47730.3 9324.4 9730.5 9733.2 10066.6 10159.3 16070.9 16086.4 16221.2 16288.8 16298.8 7546.9 7768.4 7774.8 7797.2 7822.9 4066.0 4081.9 4098.2 4109.0 4116.5 2991.9 3059.1 3066.1 3071.6 3080.8 566.6 570.0 570.1 576.0 577.0 638.7 642.2 658.6 665.3 681.9 7867.4 7983.3 7998.5 7999.4 8212.6 516.0 548.6 549.0 625.2 660.8 3893.6 3894.9 3967.9 4018.6 4181.5 53224.5 54061.0 54395.2 54427.9 54484.7 48670.0 49028.0 49349.3 50076.0 50514.5 44454.6 45094.0 45353.7 45534.8 46121.8 8571.9 8651.2 8849.2 8983.3 9026.5 31965.5 32670.8 32890.8 32896.8 34674.3 43165.0 43268.4 43352.3 43668.6 43794.6 11583.8 11632.8 11692.2 11863.9 11887.4 12439.4 12444.7 12466.6 12572.1 12596.4 11112.3 11117.4 11322.6 11596.5 11796.3 10778.6 11199.2 11302.1 11522.6 11590.8 10948.3 11169.6 11249.3 11659.5 11741.0 10004.1 10017.6 10037.3 10198.3 10373.6 9255.4 9410.2 9922.0 9952.7 10035.8 17:45:06 INFO - PROCESS | 3477 | -------- Summary: end -------- 17:45:06 INFO - PROCESS | 3477 | 17:45:07 INFO - TEST-INFO | 3477: exit 0 17:45:07 INFO - TEST-OK | dromaeo_css | took 1112022ms 17:45:07 INFO - TEST-START | kraken 17:45:07 INFO - operating with platform_type : linux_ 17:45:07 INFO - Initialising browser for kraken test... 17:45:07 INFO - TEST-INFO | started process 3721 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSRTyv2/profile http://localhost:35347/getInfo.html) 17:45:10 INFO - PROCESS | 3721 | 17:45:10 INFO - PROCESS | 3721 | (process:3794): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:45:11 INFO - PROCESS | 3721 | __metrics Screen width/height:1600/1200 17:45:11 INFO - PROCESS | 3721 | colorDepth:24 17:45:11 INFO - PROCESS | 3721 | Browser inner width/height: 1024/697 17:45:11 INFO - PROCESS | 3721 | __metrics 17:45:11 INFO - PROCESS | 3721 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:45:12 INFO - TEST-INFO | 3721: exit 0 17:45:12 INFO - Browser initialized. 17:45:12 INFO - Running cycle 1/1 for kraken test... 17:45:12 INFO - TEST-INFO | started process 3843 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSRTyv2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:13 INFO - PROCESS | 3843 | 17:45:13 INFO - PROCESS | 3843 | (process:3903): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:45:24 INFO - PROCESS | 3843 | RSS: Main: 152219648 17:45:24 INFO - PROCESS | 3843 | 17:45:26 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35347/tests/kraken/driver.html?testName=audio-beat-detection) 17:45:27 INFO - PROCESS | 3843 | RSS: Main: 154918912 17:45:27 INFO - PROCESS | 3843 | 17:45:30 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35347/tests/kraken/driver.html?testName=audio-dft) 17:45:30 INFO - PROCESS | 3843 | RSS: Main: 158883840 17:45:30 INFO - PROCESS | 3843 | 17:45:33 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35347/tests/kraken/driver.html?testName=audio-fft) 17:45:34 INFO - PROCESS | 3843 | RSS: Main: 153468928 17:45:34 INFO - PROCESS | 3843 | 17:45:36 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35347/tests/kraken/driver.html?testName=audio-oscillator) 17:45:36 INFO - PROCESS | 3843 | RSS: Main: 153006080 17:45:36 INFO - PROCESS | 3843 | 17:45:39 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:45:39 INFO - PROCESS | 3843 | RSS: Main: 152727552 17:45:39 INFO - PROCESS | 3843 | 17:45:42 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35347/tests/kraken/driver.html?testName=imaging-darkroom) 17:45:43 INFO - PROCESS | 3843 | RSS: Main: 152727552 17:45:43 INFO - PROCESS | 3843 | 17:45:46 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35347/tests/kraken/driver.html?testName=imaging-desaturate) 17:45:47 INFO - PROCESS | 3843 | RSS: Main: 152932352 17:45:47 INFO - PROCESS | 3843 | 17:45:50 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35347/tests/kraken/driver.html?testName=json-parse-financial) 17:45:50 INFO - PROCESS | 3843 | RSS: Main: 152932352 17:45:50 INFO - PROCESS | 3843 | 17:45:52 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:45:53 INFO - PROCESS | 3843 | RSS: Main: 153616384 17:45:53 INFO - PROCESS | 3843 | 17:45:54 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:45:55 INFO - PROCESS | 3843 | RSS: Main: 153198592 17:45:55 INFO - PROCESS | 3843 | 17:45:57 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:45:58 INFO - PROCESS | 3843 | RSS: Main: 152846336 17:45:58 INFO - PROCESS | 3843 | 17:46:00 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:46:01 INFO - PROCESS | 3843 | RSS: Main: 154480640 17:46:01 INFO - PROCESS | 3843 | 17:46:03 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:46:04 INFO - PROCESS | 3843 | RSS: Main: 154591232 17:46:04 INFO - PROCESS | 3843 | 17:46:05 INFO - PROCESS | 3843 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35347/tests/kraken/driver.html?testName=ai-astar) 17:46:06 INFO - PROCESS | 3843 | RSS: Main: 155144192 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | __start_tp_report 17:46:06 INFO - PROCESS | 3843 | _x_x_mozilla_page_load 17:46:06 INFO - PROCESS | 3843 | _x_x_mozilla_page_load_details 17:46:06 INFO - PROCESS | 3843 | |i|pagename|runs| 17:46:06 INFO - PROCESS | 3843 | |0;ai-astar;113;107;109;112;111;122;113;112;110;111 17:46:06 INFO - PROCESS | 3843 | |1;audio-beat-detection;157;129;154;167;135;157;163;134;161;135 17:46:06 INFO - PROCESS | 3843 | |2;audio-dft;163;163;163;162;161;161;159;163;168;162 17:46:06 INFO - PROCESS | 3843 | |3;audio-fft;76;74;73;73;73;123;75;76;73;73 17:46:06 INFO - PROCESS | 3843 | |4;audio-oscillator;96;96;144;96;95;98;142;95;97;138 17:46:06 INFO - PROCESS | 3843 | |5;imaging-gaussian-blur;119;116;115;116;115;115;116;116;115;117 17:46:06 INFO - PROCESS | 3843 | |6;imaging-darkroom;146;145;148;147;147;147;147;147;146;147 17:46:06 INFO - PROCESS | 3843 | |7;imaging-desaturate;97;97;97;97;97;97;97;96;96;96 17:46:06 INFO - PROCESS | 3843 | |8;json-parse-financial;60;60;59;59;61;61;60;62;67;58 17:46:06 INFO - PROCESS | 3843 | |9;json-stringify-tinderbox;68;67;69;68;68;67;67;67;67;67 17:46:06 INFO - PROCESS | 3843 | |10;stanford-crypto-aes;83;84;86;84;84;84;83;86;86;85 17:46:06 INFO - PROCESS | 3843 | |11;stanford-crypto-ccm;125;115;117;126;124;126;121;122;124;123 17:46:06 INFO - PROCESS | 3843 | |12;stanford-crypto-pbkdf2;136;147;145;136;147;131;144;144;141;143 17:46:06 INFO - PROCESS | 3843 | |13;stanford-crypto-sha256-iterative;69;67;68;66;68;69;68;69;73;69 17:46:06 INFO - PROCESS | 3843 | __end_tp_report 17:46:06 INFO - PROCESS | 3843 | __start_cc_report 17:46:06 INFO - PROCESS | 3843 | _x_x_mozilla_cycle_collect,763 17:46:06 INFO - PROCESS | 3843 | __end_cc_report 17:46:06 INFO - PROCESS | 3843 | __startTimestamp1453945566223__endTimestamp 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | ------- Summary: start ------- 17:46:06 INFO - PROCESS | 3843 | Number of tests: 14 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:3.97 (3.5%) stddev-sans-first:4.20 17:46:06 INFO - PROCESS | 3843 | Values: 113.0 107.0 109.0 112.0 111.0 122.0 113.0 112.0 110.0 111.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:157.00 stddev:14.27 (9.1%) stddev-sans-first:14.86 17:46:06 INFO - PROCESS | 3843 | Values: 157.0 129.0 154.0 167.0 135.0 157.0 163.0 134.0 161.0 135.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:2.32 (1.4%) stddev-sans-first:2.46 17:46:06 INFO - PROCESS | 3843 | Values: 163.0 163.0 163.0 162.0 161.0 161.0 159.0 163.0 168.0 162.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#3] audio-fft Cycles:10 Average:78.90 Median:73.50 stddev:15.55 (21.2%) stddev-sans-first:16.45 17:46:06 INFO - PROCESS | 3843 | Values: 76.0 74.0 73.0 73.0 73.0 123.0 75.0 76.0 73.0 73.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.00 stddev:21.89 (22.8%) stddev-sans-first:22.65 17:46:06 INFO - PROCESS | 3843 | Values: 96.0 96.0 144.0 96.0 95.0 98.0 142.0 95.0 97.0 138.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.00 stddev:1.25 (1.1%) stddev-sans-first:0.71 17:46:06 INFO - PROCESS | 3843 | Values: 119.0 116.0 115.0 116.0 115.0 115.0 116.0 116.0 115.0 117.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 17:46:06 INFO - PROCESS | 3843 | Values: 146.0 145.0 148.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:46:06 INFO - PROCESS | 3843 | Values: 97.0 97.0 97.0 97.0 97.0 97.0 97.0 96.0 96.0 96.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:60.50 stddev:2.50 (4.1%) stddev-sans-first:2.64 17:46:06 INFO - PROCESS | 3843 | Values: 60.0 60.0 59.0 59.0 61.0 61.0 60.0 62.0 67.0 58.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 17:46:06 INFO - PROCESS | 3843 | Values: 68.0 67.0 69.0 68.0 68.0 67.0 67.0 67.0 67.0 67.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:1.18 (1.4%) stddev-sans-first:1.12 17:46:06 INFO - PROCESS | 3843 | Values: 83.0 84.0 86.0 84.0 84.0 84.0 83.0 86.0 86.0 85.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:124.00 stddev:3.71 (3.0%) stddev-sans-first:3.81 17:46:06 INFO - PROCESS | 3843 | Values: 125.0 115.0 117.0 126.0 124.0 126.0 121.0 122.0 124.0 123.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:144.00 stddev:5.36 (3.7%) stddev-sans-first:5.32 17:46:06 INFO - PROCESS | 3843 | Values: 136.0 147.0 145.0 136.0 147.0 131.0 144.0 144.0 141.0 143.0 17:46:06 INFO - PROCESS | 3843 | 17:46:06 INFO - PROCESS | 3843 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.84 (2.7%) stddev-sans-first:1.94 17:46:06 INFO - PROCESS | 3843 | Values: 69.0 67.0 68.0 66.0 68.0 69.0 68.0 69.0 73.0 69.0 17:46:06 INFO - PROCESS | 3843 | -------- Summary: end -------- 17:46:06 INFO - PROCESS | 3843 | 17:46:07 INFO - TEST-INFO | 3843: exit 0 17:46:07 INFO - TEST-OK | kraken | took 59763ms 17:46:07 INFO - TEST-START | v8_7 17:46:07 INFO - operating with platform_type : linux_ 17:46:07 INFO - Initialising browser for v8_7 test... 17:46:07 INFO - TEST-INFO | started process 4131 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBLaTD8/profile http://localhost:35347/getInfo.html) 17:46:10 INFO - PROCESS | 4131 | 17:46:10 INFO - PROCESS | 4131 | (process:4202): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:46:11 INFO - PROCESS | 4131 | __metrics Screen width/height:1600/1200 17:46:11 INFO - PROCESS | 4131 | colorDepth:24 17:46:11 INFO - PROCESS | 4131 | Browser inner width/height: 1024/697 17:46:11 INFO - PROCESS | 4131 | __metrics 17:46:11 INFO - PROCESS | 4131 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:46:12 INFO - TEST-INFO | 4131: exit 0 17:46:12 INFO - Browser initialized. 17:46:12 INFO - Running cycle 1/1 for v8_7 test... 17:46:12 INFO - TEST-INFO | started process 4251 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBLaTD8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:13 INFO - PROCESS | 4251 | 17:46:13 INFO - PROCESS | 4251 | (process:4307): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:46:23 INFO - PROCESS | 4251 | RSS: Main: 150798336 17:46:23 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | Cycle 1(1): loaded http://localhost:35347/tests/v8_7/run.html (next: http://localhost:35347/tests/v8_7/run.html) 17:46:46 INFO - PROCESS | 4251 | RSS: Main: 152330240 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | __start_tp_report 17:46:46 INFO - PROCESS | 4251 | _x_x_mozilla_page_load 17:46:46 INFO - PROCESS | 4251 | _x_x_mozilla_page_load_details 17:46:46 INFO - PROCESS | 4251 | |i|pagename|runs| 17:46:46 INFO - PROCESS | 4251 | |0;Richards;167.6727028839705 17:46:46 INFO - PROCESS | 4251 | |1;DeltaBlue;189.3939393939394 17:46:46 INFO - PROCESS | 4251 | |2;Encrypt;273.8975623116954 17:46:46 INFO - PROCESS | 4251 | |3;Decrypt;5240.837696335078 17:46:46 INFO - PROCESS | 4251 | |4;RayTrace;1046.0251046025105 17:46:46 INFO - PROCESS | 4251 | |5;Earley;716.8458781362007 17:46:46 INFO - PROCESS | 4251 | |6;Boyer;12219.512195121952 17:46:46 INFO - PROCESS | 4251 | |7;RegExp;40760 17:46:46 INFO - PROCESS | 4251 | |8;Splay;624.6134817563388 17:46:46 INFO - PROCESS | 4251 | |9;NavierStokes;4817.307692307692 17:46:46 INFO - PROCESS | 4251 | __end_tp_report 17:46:46 INFO - PROCESS | 4251 | __startTimestamp1453945606665__endTimestamp 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | ------- Summary: start ------- 17:46:46 INFO - PROCESS | 4251 | Number of tests: 10 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | [#0] Richards Cycles:1 Average:167.67 Median:167.67 stddev:0.00 (0.0%) 17:46:46 INFO - PROCESS | 4251 | Values: 167.7 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | [#1] DeltaBlue Cycles:1 Average:189.39 Median:189.39 stddev:0.00 (0.0%) 17:46:46 INFO - PROCESS | 4251 | Values: 189.4 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | [#2] Encrypt Cycles:1 Average:273.90 Median:273.90 stddev:0.00 (0.0%) 17:46:46 INFO - PROCESS | 4251 | Values: 273.9 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 17:46:46 INFO - PROCESS | 4251 | Values: 5240.8 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | [#4] RayTrace Cycles:1 Average:1046.03 Median:1046.03 stddev:0.00 (0.0%) 17:46:46 INFO - PROCESS | 4251 | Values: 1046.0 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | [#5] Earley Cycles:1 Average:716.85 Median:716.85 stddev:0.00 (0.0%) 17:46:46 INFO - PROCESS | 4251 | Values: 716.8 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 17:46:46 INFO - PROCESS | 4251 | Values: 12219.5 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | [#7] RegExp Cycles:1 Average:40760.00 Median:40760.00 stddev:0.00 (0.0%) 17:46:46 INFO - PROCESS | 4251 | Values: 40760.0 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | [#8] Splay Cycles:1 Average:624.61 Median:624.61 stddev:0.00 (0.0%) 17:46:46 INFO - PROCESS | 4251 | Values: 624.6 17:46:46 INFO - PROCESS | 4251 | 17:46:46 INFO - PROCESS | 4251 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 17:46:46 INFO - PROCESS | 4251 | Values: 4817.3 17:46:46 INFO - PROCESS | 4251 | -------- Summary: end -------- 17:46:46 INFO - PROCESS | 4251 | 17:46:47 INFO - TEST-INFO | 4251: exit 0 17:46:47 INFO - TEST-OK | v8_7 | took 40457ms 17:46:47 INFO - SUITE-END | took 1212s 17:46:47 INFO - Completed test suite (00:20:12) 17:46:47 INFO - Working with test: dromaeo_css 17:46:47 INFO - Generating results file: dromaeo_css 17:46:47 INFO - Working with test: kraken 17:46:47 INFO - Generating results file: kraken 17:46:47 INFO - javascript benchmark 17:46:47 INFO - Working with test: v8_7 17:46:47 INFO - Generating results file: v8_7 17:46:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:46:47 INFO - process_Request line: dromaeo_css 6753.41 graph.html#tests=[[72,64,43]] 17:46:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:47 INFO - process_Request line: kraken 1516.70 graph.html#tests=[[232,64,43]] 17:46:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:47 INFO - process_Request line: v8_7 20377.34 graph.html#tests=[[230,64,43]] 17:46:47 INFO - RETURN: dromaeo_css: 6753.41 17:46:47 INFO - RETURN: kraken: 1516.70 17:46:47 INFO - RETURN: v8_7: 20377.34 17:46:47 INFO - javascript benchmark 17:46:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3189.760767942404, 3191.0267368452614, 3227.3867965086647, 3235.3529294141163, 3243.172990887324, 5172.45689202633, 5196.662216955895, 5197.1944348625975, 5199.948000519994, 5297.0, 5141.305923700299, 5182.481751824816, 5192.766325515351, 5244.475552444754, 5321.547668448186, 4651.162790697673, 4719.339292499053, 4766.189747742875, 4812.639052071091, 4812.903741925159, 412.60245089121213, 4708.176069187895, 4818.855434336975, 4858.368412106439, 4865.318855360252, 4671.462781780105, 4812.566868981791, 4842.4189097308545, 4846.442659094214, 4850.6362022848425, 4843.15244832153, 4844.2733589961435, 4850.029994001214, 4879.682820616684, 4903.803847846082, 4740.241561350167, 4812.0, 4812.230043193107, 4842.104210720992, 4843.612510999147, 5003.724050367133, 5043.773030213649, 5055.898882022376, 5096.61775366849, 5155.871103222412, 5555.527780138693, 5668.744906479218, 5675.1770993205755, 5675.886482270332, 5720.656760594377, 5462.590305727086, 5548.389677135512, 5691.630044047124, 5724.169995350692, 5746.626469279484, 5221.112410890158, 5245.527902488756, 5248.343957005412, 5250.159974404077, 5282.286891269668, 5647.350554686182, 5689.203511508392, 5698.145278208219, 5703.144528320785, 5748.9425105748405, 5399.919001214985, 5418.972905135449, 5436.939796739598, 5443.156310771837, 5529.695866727368, 5631.465010823965, 5633.859153521113, 5634.464725851038, 5641.9435805641415, 5677.205191273225, 5568.303962004749, 5594.216809646653, 5615.157726341, 5623.409541998031, 5639.013172694762, 5540.667559946416, 5574.693391863487, 5590.888182236333, 5598.58010649203, 5672.943270567324, 4368.475782906072, 4371.78141092944, 4394.099209662011, 4397.670174736908, 4436.511983681792, 3877.0888841122314, 3926.3521518949624, 3926.725129240983, 3968.861089861841, 3980.144268982183, 5050.646454748133, 5104.795808167706, 5116.539511443988, 5120.667156634807, 5138.58891288696, 5417.052015897202, 5465.371482279589, 5472.0, 5472.343318801769, 5478.91781623276, 5077.644564880423, 5124.641275110706, 5132.615053870974, 5158.38099428071, 5167.173252279617, 4698.3187437821325, 4710.24636058229, 4722.905541889143, 4767.046590681877, 4812.06164797868, 5757.453041961007, 5763.0202865512965, 5788.942110578924, 5815.854603634943, 5816.70916454184, 5586.050371436947, 5599.972000139973, 5605.32736071674, 5606.271184745957, 5611.5230205433, 5625.09998400254, 5654.802081927113, 5741.827745167485, 5746.741396637078, 5797.623154494944, 5421.674699518042, 5469.343678758574, 5470.480304371078, 5471.151971444432, 5500.724963751716, 5526.41972592888, 5557.305336832896, 5575.888482230252, 5576.10782274834, 5642.435756424489, 5380.677159370451, 5427.810026649048, 5436.40199578054, 5527.640703354269, 5613.24221230145, 5495.313085864267, 5521.585881058856, 5537.916931246115, 5540.030494663499, 5545.140503222007, 5381.058314794817, 5442.319710036246, 5443.183522471661, 5450.91823622638, 5503.0, 5320.813771517978, 5383.488568585978, 5460.863478413072, 5559.916601251065, 5588.2455868458865, 5381.623286370073, 5383.650062745909, 5427.6200665953, 5428.07722687152, 5428.267183930119], "unit": "score", "name": "dojo.html", "value": 5132.959228849835}, {"lowerIsBetter": false, "replicates": [508.0524821208445, 545.9563234941205, 552.0945649135418, 559.8992181407345, 564.4045531963778, 35061.64938350622, 35135.0, 35679.0, 35693.82153089234, 35773.284534309365, 39351.80324098383, 39664.405033924515, 39782.40326395106, 39801.40297895534, 40055.59944400555, 8476.15238476152, 8588.484690918534, 8644.351673624471, 8664.696735614254, 8672.306215502776, 8365.539895305787, 8513.233808957193, 8518.148185181495, 8742.606582703762, 8751.0, 8695.0, 8750.737477875675, 8778.60496277669, 8784.209421152094, 8792.47245165289, 8637.222649961503, 8676.392652514327, 8696.521691306976, 8712.303015758756, 8742.0, 8542.87185692209, 8662.09048049952, 8670.306375489945, 8677.826443471095, 8722.34582406322, 39833.0, 39882.60117398818, 40014.599854001375, 40273.59726402728, 40335.596644033474, 3162.3359094589932, 3193.3913439680687, 3289.523019162208, 3301.8209377929393, 3953.4267531207815, 28787.136385908456, 29119.708802912122, 29683.257918552208, 29723.554146687817, 29767.25581860449, 3355.1782345347833, 3383.695467407945, 3440.2947395783804, 3491.0574144980715, 3497.91255218619, 255299.0, 257712.0, 258189.0, 258416.0, 258478.0, 51552.22671659928, 52531.21203181955, 55972.16041759377, 58518.41481585215, 59461.405385946455, 52604.47395526072, 52635.210471842955, 52854.0, 52862.0, 53056.0, 16005.679886402208, 16029.67940641204, 16162.111083890264, 16261.918690406472, 16339.754903676454, 11745.530178792924, 11745.765084698429, 11825.586104486301, 11850.170488065753, 11867.465964031639, 19264.711029334572, 19539.072160835913, 19602.21591136367, 19635.31276405319, 19707.704384434244, 7323.0, 7349.522281051714, 7350.742724004741, 7380.741674041383, 7430.331270185601, 863.8747381629629, 887.5784002598714, 1013.0730381700808, 1047.8009178256107, 1103.906167975715, 28180.43639127206, 28334.149975500768, 29846.25384365408, 30802.229944251125, 31488.212794679857, 981.5828272983953, 988.2983082011708, 992.8709267795141, 1058.7406085509099, 1108.2906939558688, 12065.155439119353, 12482.937585312015, 12536.686582835502, 12593.181443206346, 12672.303023333805, 335645.0, 335911.0, 336311.0, 340071.0, 341070.0, 44672.77663611726, 44682.10635787331, 44899.0, 45215.77392113018, 45623.0, 1348.6560926963757, 1367.3710093357167, 1377.5591810620506, 1384.1418320641267, 1386.0574809129687, 23120.306390808302, 23921.0, 29070.27324316909, 31332.373352532366, 31375.21561960969, 47027.0, 47327.29009064936, 47438.28842567295, 47608.52391476041, 47650.285245722036, 255326.0, 255432.0, 256355.0, 256492.0, 257371.0, 31238.0, 32178.0, 32452.675473244966, 32604.673953260164, 32656.51015234726, 41001.0, 41862.79068604638, 43346.34980475358, 43463.130737385705, 44249.11501770011, 32344.259285902062, 34671.65328346684, 35110.64889351176, 35715.28569428545, 35801.0, 34376.0, 35539.11152221215, 36099.458508121876, 36314.092147696516, 39414.605853941095, 33010.83494582512, 33039.0, 33171.83414082914, 33367.665293387996, 33602.32795344129, 31030.53454198234, 31708.207294817814, 32147.51778723368, 32433.837830810695, 32521.512177317833, 23306.184283549996, 23792.88103559471, 23971.28086157418, 24199.395015124057, 24221.51556968886], "unit": "score", "name": "ext.html", "value": 17891.380822069674}, {"lowerIsBetter": false, "replicates": [363.06329669452816, 363.99454008189883, 366.53816191598577, 367.80322527447805, 368.2469350178883, 15339.0, 16617.50147495574, 16873.156342182872, 17519.73720394192, 17717.911410442946, 11055.72360690983, 11260.605878794244, 16428.83571164288, 16528.83471165291, 16594.66810663786, 4878.78045487953, 5458.972705136469, 5459.590530710193, 5462.071447853855, 5520.613557051008, 5281.287026251464, 5360.865978350553, 5425.321834770653, 5437.211604317372, 5494.560435165177, 4869.902601947977, 5005.124103281929, 5410.675359478424, 5462.754176062067, 5468.781248750065, 4937.136001199776, 4959.454460009396, 4970.080535100999, 5006.674566153189, 5030.974845125769, 5073.34046573943, 5080.720560369178, 5088.796448142107, 5089.083964886319, 5089.592832573422, 12178.0, 14632.487862924747, 19027.334043308558, 19653.60692786136, 19681.40955771329, 2015.9294424695213, 2021.4744166516664, 2036.3483685220735, 2048.4878780304775, 2142.8500004999655, 9277.396969196981, 9487.193588544982, 9543.188828949547, 9588.856167157499, 11089.445527723581, 1595.7606359046235, 1664.1263336748184, 1718.510224585987, 1823.6990896502061, 1862.0596598717696, 54187.458125418634, 55177.72411137959, 55748.44251557514, 57309.26556093087, 57466.42533574653, 9746.220302375792, 10051.547680354402, 10121.139703125169, 10179.338343007681, 10203.979602039737, 13015.479380824661, 13189.538366157138, 13213.669658258621, 13213.73572528544, 13236.272005039622, 7718.266764657348, 7723.613819309125, 7746.109197442253, 7804.843903121906, 7805.453618246782, 7530.359919406912, 7569.810754731176, 7570.318671319607, 7608.277213664693, 7644.159142494321, 4376.277914144131, 4400.735955842596, 4423.07115505741, 4425.933610995773, 4431.468223813163, 1831.3224107080466, 1846.7876194237836, 1860.3209828412532, 1881.9529511762316, 1904.9238030478625, 416.40662056569266, 422.6618705035959, 434.07975092803457, 442.8317239448989, 457.40994117588605, 9645.807083858284, 10045.497725113715, 10283.382997020202, 10311.07200351972, 10348.016938390841, 452.19509273492577, 453.46491140453924, 463.59203900567957, 467.2057502246195, 488.2310361181154, 5445.673259604437, 5568.972155139199, 5572.3034620672415, 5654.6324488908085, 5899.085641725539, 352736.0, 357788.0, 362238.0, 505613.0, 511137.0, 67939.32060679428, 72661.0, 73113.6344318275, 74269.6286518564, 74639.62680186564, 1141.5262665993519, 1170.0639488409238, 1170.9648710538697, 1172.3200543684643, 1191.2911817468419, 14769.778453322993, 14824.407023719363, 14846.099635721146, 14895.553133406016, 15037.849621504083, 29453.26366840846, 29843.253918652208, 29876.0, 30363.84818075984, 31310.530342044432, 36323.0, 39410.40884386679, 39566.0, 40891.59108408878, 41561.79219104006, 2863.0838131797623, 2881.0924558763923, 5963.13534537481, 6967.372936435745, 7142.714291428285, 10263.12763415118, 10676.62631807883, 10730.248882578144, 11666.533338666359, 11834.704132396415, 7346.595937223504, 8522.616482258189, 8812.734381233677, 9203.40177888435, 9581.616735330508, 9834.164096051916, 9858.457784821903, 9909.554070067008, 10004.0, 10211.0, 6477.287498375081, 6911.827204319932, 7020.894686579603, 7316.743913963199, 9310.674126405544, 9243.701653890219, 10027.749306267402, 10333.638322658671, 10357.792844143225, 10515.106215971728, 9470.289728270269, 9553.904460955302, 9557.761055973657, 9701.17540009079, 9761.707148785548], "unit": "score", "name": "jquery.html", "value": 7390.9550021680825}, {"lowerIsBetter": false, "replicates": [1475.4909556203108, 1519.6504803895107, 1674.8995060296384, 1772.5745821002963, 1796.838284554389, 7664.11862635797, 7782.8443431131345, 7856.332211762007, 8026.959865200673, 8030.91969080309, 7762.883556746653, 7835.177306382833, 7882.369410447165, 7926.92073079269, 7944.563049032301, 2293.9541209175804, 2334.719833619968, 2337.567550003255, 2339.777721116491, 2347.4718188407555, 2298.9540209195807, 2325.3256555598855, 2332.067173130753, 2336.3575016870413, 2338.7427382987858, 2289.3589794857467, 2297.115610489965, 2318.107528601484, 2329.440934175794, 2345.2377977157407, 2278.840481166319, 2289.404754763765, 2303.7696230376914, 2307.7922986931258, 2311.318161142467, 2254.842161048727, 2315.0623997281127, 2321.257197696738, 2323.0591610397814, 2329.312852708455, 7804.297613214781, 7953.403494737918, 7959.482633628795, 7995.040595128622, 8023.117457079717, 4740.834070807505, 4765.642576806718, 4822.831200907952, 4837.8306759263605, 4847.175980083359, 3021.0, 3038.559408885699, 3058.235441139715, 3080.645725741546, 3085.3520760640295, 955.6177528988391, 955.8948515663271, 962.3311798300184, 970.6214576315243, 1003.3428104591504, 11001.779964400746, 11052.889471105267, 11100.056495197838, 11110.44447777616, 11119.221654484189, 4084.3873418986796, 4093.9795301023305, 4170.22850772608, 4180.226658068206, 4195.958040419557, 9064.456132632064, 9074.546272686339, 9086.81826363469, 9089.09109089099, 9102.86345704815, 4796.904061918742, 4798.088363210979, 4812.807487700523, 4826.300186473012, 4840.128776820206, 4393.626541743924, 4399.6040356368085, 4419.867403977822, 4421.204183246982, 4433.290673492225, 3405.233822389992, 3465.774724642941, 3466.7573269871373, 3485.006773069663, 3502.264524449843, 1023.2683631203726, 1044.6865940217904, 1057.1595581512563, 1061.5806756331206, 1063.9148868090533, 1033.379972016799, 1035.99482002591, 1066.5520481397832, 1163.743976325207, 1252.7619752247044, 7338.816529586803, 7392.963035184897, 7407.592582407911, 7413.88879166813, 7440.627968601549, 1067.5836423794726, 1092.5302120088438, 1096.1011970184372, 1105.4693747001484, 1115.297362661518, 5698.031334673115, 5744.798932037442, 5772.624779389326, 5788.044972579477, 5806.303243610793, 9276.35065545419, 9428.0, 9693.660721874701, 9753.804923901482, 9789.412635241908, 9622.37454565465, 9641.903580964101, 9642.951785241028, 9668.70993870185, 9693.70918872435, 7495.8500829983095, 7515.098188217449, 7562.697492100365, 7611.2769286917655, 7641.885371719429, 7260.0, 7308.488405811755, 7314.4514161439165, 7318.853622927618, 7378.5941773202985, 8375.748727538183, 8435.409521333448, 8658.220760131366, 8719.738407847775, 8734.73795786102, 8824.86762698573, 8911.73264802057, 8932.374733768835, 8945.821083578423, 8958.82082358336, 6753.561018533779, 6878.933765266392, 6903.827404314932, 6948.200956890022, 6953.096097507291, 7566.886496702444, 7596.240375962359, 7617.0, 7634.045744281965, 7658.042744656918, 6934.791956241321, 7044.119485064367, 7059.082319298664, 7118.359347658736, 7220.783376498714, 6301.936980630135, 6670.0, 6671.33286671329, 6724.125863637696, 6902.413294869993, 6718.059471674067, 6726.495512836459, 6735.764248251287, 6763.458923286224, 6806.591604503746, 6357.90463143044, 6368.617882927039, 6441.967790161207, 6494.935050649433, 6542.640154791342, 6586.077949087227, 6626.536142470173, 6630.569013014138, 6637.2699003108655, 6666.466682665472], "unit": "score", "name": "mootools.html", "value": 4511.729660164754}, {"lowerIsBetter": false, "replicates": [308.92740206051576, 317.6394791911181, 319.9360127974404, 320.8844815866289, 323.2887647176213, 6130.448259656636, 6257.155284036654, 6357.682115894204, 6394.680265986705, 6403.167588213531, 6182.876342473159, 6194.4115309045565, 6196.845078873031, 6240.157578726882, 6261.060840873871, 4584.106099310636, 4684.180268453024, 4690.671652984292, 4760.143174228638, 4768.904621907551, 4700.130475861959, 4716.929246061295, 4723.0, 4726.574608285254, 4744.027474367764, 4675.789589468465, 4685.9062818743605, 4686.08621318843, 4690.273007683814, 4695.131400690866, 4679.532046795311, 4687.789049492781, 4695.389599352079, 4696.483386827446, 4706.929396059062, 3966.5835087315995, 4074.449949256842, 4097.85657501986, 4103.651189648884, 4103.835846566134, 5787.623804452739, 5838.970805145947, 5871.207387002785, 5896.941030589682, 5904.557158213108, 5393.325834270716, 5393.78424863005, 5407.756650950717, 5413.26920865682, 5439.782408703687, 6439.967800161016, 6493.642849643268, 6498.772542960974, 6509.218893732735, 6513.088167656484, 4329.675274354436, 4404.295312749945, 4405.207062728708, 4427.247367947424, 4465.151621191963, 6758.155230596176, 6823.829404264883, 6842.7605033824075, 6848.315168483112, 6860.588364698084, 4525.886852828706, 4531.252343363308, 4533.32000199966, 4540.977295113569, 4574.08518296342, 4521.977390113094, 4569.223232050559, 4581.060882519142, 4590.472095708969, 4606.124836281096, 5385.515303622615, 5442.809501667422, 5456.099743542351, 5462.153366228241, 5465.262189604353, 6573.441257493167, 6580.539362244597, 6594.670266486656, 6597.670116494156, 6606.966965165239, 1633.86112180466, 1636.0674415583003, 1637.8607818335336, 1642.6386195037073, 1643.3837311008372, 1091.4651820607844, 1111.4442778610694, 1117.7987962166887, 1128.9435528223555, 1131.536070211226, 6202.0696895465135, 6262.530310226751, 6265.561410701298, 6267.4986001119805, 6305.747770089237, 6849.1438570178725, 6863.553868998499, 6870.141232345957, 6908.0674108995645, 6908.861822763617, 6243.094751261133, 6248.375162483806, 6287.559870808999, 6294.307626161119, 6295.496360291166, 3627.8730244441317, 3707.8320329096787, 3719.814009299524, 3736.9813150934615, 3748.4002559590335, 7093.113360829896, 7100.964495177491, 7106.0, 7106.5736055836815, 7111.4666400020205, 6972.407345375598, 6980.232174460805, 7017.087778588853, 7033.542819716702, 7050.506464547535, 6881.41507971818, 7064.894026589605, 7083.433325333961, 7087.92912070883, 7129.2870712929325, 6812.557183783038, 6823.727050917908, 6833.726650933907, 6839.760608378683, 6884.311568843075, 6743.35938085881, 6750.1562304711915, 6797.830054248683, 6798.898016529657, 6807.625580593115, 6914.377706006484, 7070.71717131309, 7076.080109585927, 7079.539829911039, 7085.893711594434, 4648.047150334241, 4684.0, 4697.177993851131, 4698.224792909132, 4712.458067322302, 6799.490038247052, 6812.829679258059, 6865.450763938773, 6878.793636190922, 6883.7590684325805, 6408.39120283591, 6581.9670901647105, 6673.766418175341, 6683.131192944886, 6702.899456508254, 6635.502337324817, 6651.50113741481, 6664.400203981665, 6669.0, 6690.899636505554, 6492.091107244895, 6498.967505162444, 6517.543771936109, 6543.051257567721, 6562.901556476752, 6496.9025464617125, 6613.900791488035, 6676.766313179015, 6696.83257918556, 6708.463322934251, 6449.871002580016, 6487.837804054936, 6536.3136870627895, 6544.149260596092, 6561.1470508833545], "unit": "score", "name": "prototype.html", "value": 4942.645164100912}, {"lowerIsBetter": false, "replicates": [706.0679902528664, 714.6569646569646, 796.474326944217, 796.9521828690278, 804.5896592737702, 13067.673308167301, 13176.1435506692, 13250.07249492536, 13291.534796282132, 13338.733225335487, 12644.241345519275, 12657.430415631296, 12657.936710316435, 12723.872761272385, 12742.936285318561, 768.7693691892438, 798.2496453333877, 813.2071230550225, 820.8399362124359, 822.2065706593137, 809.4010432280099, 811.736185739634, 814.1532805881906, 814.698561532234, 816.2042009041168, 846.2806614377791, 846.7713717296326, 851.1445996773234, 853.3343991686495, 854.786303424144, 831.0484495252932, 838.4214891724721, 843.9451435656663, 846.7544412120478, 849.2611428057629, 632.0582332324849, 632.4876849751715, 634.2199095112991, 635.5297080160694, 636.0268788753169, 13667.453301867914, 13833.723325533432, 13851.376688049062, 13881.167129972133, 13893.374798134108, 12204.816927746091, 12240.326782026985, 12500.062495312797, 12714.554990575285, 12953.093283470162, 10149.441780702058, 10252.436116013616, 10451.11165550929, 10493.265471417004, 10532.94733526335, 4299.527052024275, 4314.654827613784, 4330.437043184397, 4428.136513379892, 4434.091011342667, 46954.76522617399, 47617.04765904697, 47619.0, 47624.0, 47730.28404573934, 9324.393914395543, 9730.513474326255, 9733.2213422926, 10066.641003464585, 10159.288849780592, 16070.919645401698, 16086.43697470583, 16221.188940552925, 16288.837111628969, 16298.837011629968, 7546.924530754732, 7768.378529717722, 7774.766756997299, 7797.220277972157, 7822.921770782333, 4065.9796701016307, 4081.9387709184384, 4098.180363927227, 4108.968777211096, 4116.4648595682365, 2991.880324786984, 3059.0975662179267, 3066.0955018269665, 3071.6467606225124, 3080.7843450958217, 566.64301490061, 570.0, 570.0793218951446, 575.9971200144056, 577.0075470191264, 638.664701031962, 642.2132887213127, 658.5764387055585, 665.3346653346654, 681.8806708825936, 7867.370610351159, 7983.321417679563, 7998.520088794691, 7999.440039197317, 8212.63043163059, 516.0478916399237, 548.6104865545508, 548.975296111668, 625.1716475669756, 660.7885476647426, 3893.6301051400073, 3894.902627434337, 3967.92064158721, 4018.578049304839, 4181.498220213593, 53224.46775532195, 54061.0, 54395.184072238946, 54427.9179061572, 54484.72757636266, 48670.0, 49028.0, 49349.25976110361, 50075.9984800302, 50514.494855051715, 44454.55545444569, 45094.0, 45353.65048893158, 45534.772326138154, 46121.769391152826, 8571.914280857112, 8651.221390074923, 8849.159329863653, 8983.326250531105, 9026.45841249527, 31965.520517192726, 32670.83664581662, 32890.83554582212, 32896.83551582227, 34674.306513870084, 43165.0, 43268.35097473604, 43352.349714754935, 43668.56331436645, 43794.56205437905, 11583.76832463363, 11632.76734465289, 11692.181547291608, 11863.881361186277, 11887.405629718653, 12439.37803109859, 12444.688882778002, 12466.56205634006, 12572.1199516033, 12596.370181491073, 11112.277701949348, 11117.388543630179, 11322.60370887015, 11596.536138554364, 11796.29222246668, 10778.568857245937, 11199.216054876406, 11302.095832333558, 11522.596709115141, 11590.826137608112, 10948.288361256493, 11169.609063682732, 11249.268797528135, 11659.53361865516, 11741.0, 10004.149647279772, 10017.59929602837, 10037.34757240777, 10198.3339355451, 10373.585056597953, 9255.444673319622, 9410.200132988499, 9921.950390248003, 9952.694230894138, 10035.799284014132], "unit": "score", "name": "yui.html", "value": 6267.3905171201095}], "name": "dromaeo_css", "value": 6753.4048187809185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 109.0, 112.0, 111.0, 122.0, 113.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 154.0, 167.0, 135.0, 157.0, 163.0, 134.0, 161.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 162.0, 161.0, 161.0, 159.0, 163.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 73.0, 73.0, 73.0, 123.0, 75.0, 76.0, 73.0, 73.0], "unit": "score", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 144.0, 96.0, 95.0, 98.0, 142.0, 95.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 115.0, 116.0, 115.0, 115.0, 116.0, 116.0, 115.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 59.0, 61.0, 61.0, 60.0, 62.0, 67.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 86.0, 84.0, 84.0, 84.0, 83.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [125.0, 115.0, 117.0, 126.0, 124.0, 126.0, 121.0, 122.0, 124.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [136.0, 147.0, 145.0, 136.0, 147.0, 131.0, 144.0, 144.0, 141.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 66.0, 68.0, 69.0, 68.0, 69.0, 73.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1516.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.6727028839705], "unit": "score", "name": "Richards", "value": 210.54112800000007}, {"lowerIsBetter": false, "replicates": [189.3939393939394], "unit": "score", "name": "DeltaBlue", "value": 349.1030400000001}, {"lowerIsBetter": false, "replicates": [273.8975623116954], "unit": "score", "name": "Encrypt", "value": 971.8268310000004}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1046.0251046025105], "unit": "score", "name": "RayTrace", "value": 707.4294840000001}, {"lowerIsBetter": false, "replicates": [716.8458781362007], "unit": "score", "name": "Earley", "value": 929.7158849999997}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [40760.0], "unit": "score", "name": "RegExp", "value": 22.349975466143274}, {"lowerIsBetter": false, "replicates": [624.6134817563388], "unit": "score", "name": "Splay", "value": 130.46628415841582}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 20377.336624499487}]} 17:46:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20377.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1516.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6753.41"}}} 17:46:47 INFO - Return code: 0 17:46:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:46:47 INFO - # TBPL SUCCESS # 17:46:47 INFO - Running post-action listener: _resource_record_post_action 17:46:47 INFO - Running post-run listener: _resource_record_post_run 17:46:48 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 10539008; Write bytes: 441643008; Read time: 3152; Write time: 281992 17:46:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5210112; Read time: 0; Write time: 516 17:46:48 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8777728; Write bytes: 436432896; Read time: 3104; Write time: 281476 17:46:48 INFO - Running post-run listener: _upload_blobber_files 17:46:48 INFO - Blob upload gear active. 17:46:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:46:48 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 17:46:48 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'] 17:46:48 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 17:46:49 INFO - (blobuploader) - INFO - Open directory for files ... 17:46:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:46:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:46:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:50 INFO - (blobuploader) - INFO - Done attempting. 17:46:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:46:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:46:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:51 INFO - (blobuploader) - INFO - Done attempting. 17:46:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:46:51 INFO - Return code: 0 17:46:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:46:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:46:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8651fa8c251b31b44c4ddc370103c9576312c185be6d39cea7506a9bc7b5fdc7327e3287468241efa04e4700a7e0e9e834d8b9869bc3a247d249b2ec42526a4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b2baeea7978b5afbf8dcf92987068ed04131e3389115257d43430385343125c998073da1429a65cfc1540d19ed019526ab4ef8e57a3867950b8cc09e2b5ffc4"} 17:46:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:46:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:46:51 INFO - Contents: 17:46:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8651fa8c251b31b44c4ddc370103c9576312c185be6d39cea7506a9bc7b5fdc7327e3287468241efa04e4700a7e0e9e834d8b9869bc3a247d249b2ec42526a4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b2baeea7978b5afbf8dcf92987068ed04131e3389115257d43430385343125c998073da1429a65cfc1540d19ed019526ab4ef8e57a3867950b8cc09e2b5ffc4"} 17:46:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:46:51 INFO - Copying logs to upload dir... 17:46:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:46:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.802100 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-27 17:46:51.148826) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 17:46:51.153037) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8651fa8c251b31b44c4ddc370103c9576312c185be6d39cea7506a9bc7b5fdc7327e3287468241efa04e4700a7e0e9e834d8b9869bc3a247d249b2ec42526a4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b2baeea7978b5afbf8dcf92987068ed04131e3389115257d43430385343125c998073da1429a65cfc1540d19ed019526ab4ef8e57a3867950b8cc09e2b5ffc4"} build_url:https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011071 build_url: 'https://queue.taskcluster.net/v1/task/J6g2BcpSS32TgtaIYu248w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8651fa8c251b31b44c4ddc370103c9576312c185be6d39cea7506a9bc7b5fdc7327e3287468241efa04e4700a7e0e9e834d8b9869bc3a247d249b2ec42526a4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b2baeea7978b5afbf8dcf92987068ed04131e3389115257d43430385343125c998073da1429a65cfc1540d19ed019526ab4ef8e57a3867950b8cc09e2b5ffc4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 17:46:51.178417) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 17:46:51.178774) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453943700.68429-1967495501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 17:46:51.260669) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 17:46:51.261004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 17:46:51.261358) ========= ========= Total master_lag: 0.26 =========