builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1453391498.11 results: success (0) buildid: 20160120073402 builduid: f9f44c436add4a1d8910ad9c9d3d91ad revision: 6764bc656c1d146962d53710d734c2ac87c2306f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.114447) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.114949) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.115254) ========= 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=0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.163883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.164272) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.188112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.188534) ========= 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=0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004695 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.238201) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.238530) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.238922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.239221) ========= 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=0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 07:51: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-21 07:51:38 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.367898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.368298) ========= 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=0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022285 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.418313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 07:51:38.418709) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6764bc656c1d146962d53710d734c2ac87c2306f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6764bc656c1d146962d53710d734c2ac87c2306f --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=0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 07:51:39,018 truncating revision to first 12 chars 2016-01-21 07:51:39,018 Setting DEBUG logging. 2016-01-21 07:51:39,019 attempt 1/10 2016-01-21 07:51:39,019 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6764bc656c1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 07:51:40,305 unpacking tar archive at: mozilla-central-6764bc656c1d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.586667 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 07:51:40.019116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:40.019588) ========= echo 6764bc656c1d146962d53710d734c2ac87c2306f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6764bc656c1d146962d53710d734c2ac87c2306f'] 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=0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6764bc656c1d146962d53710d734c2ac87c2306f program finished with exit code 0 elapsedTime=0.003765 script_repo_revision: '6764bc656c1d146962d53710d734c2ac87c2306f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:40.067913) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:40.068255) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:40.079537) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:40.079932) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/6764bc656c1d146962d53710d734c2ac87c2306f ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:40.080432) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-21 07:51:40.080720) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:51:40 INFO - MultiFileLogger online at 20160121 07:51:40 in /builds/slave/test-pgo 07:51:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:51:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:51:40 INFO - {'append_to_log': False, 07:51:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:51:40 INFO - 'blob_upload_branch': 'Firefox', 07:51:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:51:40 INFO - 'branch': 'Firefox', 07:51:40 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:40 INFO - 'config_files': ('talos/linux_config.py',), 07:51:40 INFO - 'default_actions': ('clobber', 07:51:40 INFO - 'read-buildbot-config', 07:51:40 INFO - 'download-and-extract', 07:51:40 INFO - 'populate-webroot', 07:51:40 INFO - 'create-virtualenv', 07:51:40 INFO - 'install', 07:51:40 INFO - 'run-tests'), 07:51:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:40 INFO - 'download_minidump_stackwalk': True, 07:51:40 INFO - 'download_symbols': 'ondemand', 07:51:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:40 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:40 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:40 INFO - 'installer_path': 'installer.exe', 07:51:40 INFO - 'log_level': 'info', 07:51:40 INFO - 'log_name': 'talos', 07:51:40 INFO - 'log_to_console': True, 07:51:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:51:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:51:40 INFO - 'opt_config_files': (), 07:51:40 INFO - 'pip_index': False, 07:51:40 INFO - 'sps_profile': False, 07:51:40 INFO - 'sps_profile_interval': 0, 07:51:40 INFO - 'suite': 'dromaeojs', 07:51:40 INFO - 'system_bits': '32', 07:51:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:40 INFO - 'title': 'talos-linux64-ix-058', 07:51:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:40 INFO - 'use_talos_json': True, 07:51:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:51:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:40 INFO - 'work_dir': 'build'} 07:51:40 INFO - ##### 07:51:40 INFO - ##### Running clobber step. 07:51:40 INFO - ##### 07:51:40 INFO - Running pre-action listener: _resource_record_pre_action 07:51:40 INFO - Running main action method: clobber 07:51:40 INFO - rmtree: /builds/slave/test-pgo/build 07:51:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:51:41 INFO - Running post-action listener: _resource_record_post_action 07:51:41 INFO - ##### 07:51:41 INFO - ##### Running read-buildbot-config step. 07:51:41 INFO - ##### 07:51:41 INFO - Running pre-action listener: _resource_record_pre_action 07:51:41 INFO - Running main action method: read_buildbot_config 07:51:41 INFO - Using buildbot properties: 07:51:41 INFO - { 07:51:41 INFO - "project": "", 07:51:41 INFO - "product": "firefox", 07:51:41 INFO - "script_repo_revision": "production", 07:51:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:51:41 INFO - "repository": "", 07:51:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:51:41 INFO - "buildid": "20160120073402", 07:51:41 INFO - "pgo_build": "True", 07:51:41 INFO - "basedir": "/builds/slave/test-pgo", 07:51:41 INFO - "buildnumber": 650, 07:51:41 INFO - "slavename": "talos-linux64-ix-058", 07:51:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:51:41 INFO - "platform": "ubuntu64_hw", 07:51:41 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:51:41 INFO - "branch": "mozilla-central", 07:51:41 INFO - "repo_path": "mozilla-central", 07:51:41 INFO - "revision": "6764bc656c1d146962d53710d734c2ac87c2306f", 07:51:41 INFO - "stage_platform": "linux64-pgo", 07:51:41 INFO - "builduid": "f9f44c436add4a1d8910ad9c9d3d91ad", 07:51:41 INFO - "slavebuilddir": "test" 07:51:41 INFO - } 07:51:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:51:41 INFO - Running post-action listener: _resource_record_post_action 07:51:41 INFO - ##### 07:51:41 INFO - ##### Running download-and-extract step. 07:51:41 INFO - ##### 07:51:41 INFO - Running pre-action listener: _resource_record_pre_action 07:51:41 INFO - Running main action method: download_and_extract 07:51:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:51:41 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')]} 07:51:41 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json 07:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json 07:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:51:42 INFO - Downloaded 1448 bytes. 07:51:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:51:42 INFO - Using the following test package requirements: 07:51:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:51:42 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:51:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'jsshell-linux-x86_64.zip'], 07:51:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:51:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:51:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:51:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:51:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:51:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:42 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:51:44 INFO - Downloaded 22485896 bytes. 07:51:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:51:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:51:45 INFO - Return code: 0 07:51:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:45 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:51:46 INFO - Downloaded 22485896 bytes. 07:51:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:51:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:51:48 INFO - Return code: 0 07:51:48 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')]} 07:51:48 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:51:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:51:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:51:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:51:49 INFO - Downloaded 11132144 bytes. 07:51:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:51:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 07:51:49 INFO - Return code: 0 07:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:49 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:51:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:51:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:51:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:51:50 INFO - Downloaded 55941556 bytes. 07:51:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:51:50 INFO - mkdir: /builds/slave/test-pgo/properties 07:51:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:51:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:51:50 INFO - Contents: 07:51:50 INFO - build_url:https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:51:50 INFO - Running post-action listener: _resource_record_post_action 07:51:50 INFO - Running post-action listener: set_extra_try_arguments 07:51:50 INFO - ##### 07:51:50 INFO - ##### Running populate-webroot step. 07:51:50 INFO - ##### 07:51:50 INFO - Running pre-action listener: _resource_record_pre_action 07:51:50 INFO - Running main action method: populate_webroot 07:51:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:51:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:51:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:51:50 INFO - '--tppagecycles', 07:51:50 INFO - '7'], 07:51:50 INFO - 'tests': ['tsvgm']}}, 07:51:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:51:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:51:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:51:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:51:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:51:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:51:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:50 INFO - 'talos_options': ['--e10s'], 07:51:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:50 INFO - 'tests': ['damp', 'tps']}, 07:51:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:50 INFO - 'talos_options': ['--e10s'], 07:51:50 INFO - 'tests': ['damp', 'tps']}, 07:51:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:51:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:51:50 INFO - 'other': {'tests': ['a11yr', 07:51:50 INFO - 'ts_paint', 07:51:50 INFO - 'tpaint', 07:51:50 INFO - 'sessionrestore', 07:51:50 INFO - 'sessionrestore_no_auto_restore']}, 07:51:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:51:50 INFO - 'tests': ['a11yr', 07:51:50 INFO - 'ts_paint', 07:51:50 INFO - 'tpaint', 07:51:50 INFO - 'sessionrestore', 07:51:50 INFO - 'sessionrestore_no_auto_restore']}, 07:51:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:51:50 INFO - 'tests': ['a11yr', 07:51:50 INFO - 'ts_paint', 07:51:50 INFO - 'tpaint', 07:51:50 INFO - 'sessionrestore', 07:51:50 INFO - 'sessionrestore_no_auto_restore']}, 07:51:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:51:50 INFO - 'tests': ['a11yr', 07:51:50 INFO - 'ts_paint', 07:51:50 INFO - 'tpaint', 07:51:50 INFO - 'sessionrestore', 07:51:50 INFO - 'sessionrestore_no_auto_restore']}, 07:51:50 INFO - 'other_l64': {'tests': ['a11yr', 07:51:50 INFO - 'ts_paint', 07:51:50 INFO - 'tpaint', 07:51:50 INFO - 'sessionrestore', 07:51:50 INFO - 'sessionrestore_no_auto_restore']}, 07:51:50 INFO - 'other_nol64': {'tests': ['a11yr', 07:51:50 INFO - 'ts_paint', 07:51:50 INFO - 'tpaint', 07:51:50 INFO - 'sessionrestore', 07:51:50 INFO - 'sessionrestore_no_auto_restore']}, 07:51:50 INFO - 'svgr': {'tests': ['tsvgx', 07:51:50 INFO - 'tsvgr_opacity', 07:51:50 INFO - 'tart', 07:51:50 INFO - 'tscrollx', 07:51:50 INFO - 'cart']}, 07:51:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:51:50 INFO - 'tests': ['tsvgx', 07:51:50 INFO - 'tsvgr_opacity', 07:51:50 INFO - 'tart', 07:51:50 INFO - 'tscrollx', 07:51:50 INFO - 'cart']}, 07:51:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:50 INFO - 'tests': ['tp5o']}, 07:51:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:50 INFO - 'talos_options': ['--e10s'], 07:51:50 INFO - 'tests': ['tp5o']}, 07:51:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:50 INFO - 'talos_options': ['--xperf_path', 07:51:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:50 INFO - 'tests': ['tp5n']}, 07:51:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:50 INFO - 'talos_options': ['--e10s', 07:51:50 INFO - '--xperf_path', 07:51:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:50 INFO - 'tests': ['tp5n']}}, 07:51:50 INFO - 'talos.zip': {'path': '', 07:51:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:51:50 INFO - Running post-action listener: _resource_record_post_action 07:51:50 INFO - ##### 07:51:50 INFO - ##### Running create-virtualenv step. 07:51:50 INFO - ##### 07:51:50 INFO - Running pre-action listener: _resource_record_pre_action 07:51:50 INFO - Running main action method: create_virtualenv 07:51:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:51:50 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 07:51:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:51:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:51:50 INFO - Using real prefix '/usr' 07:51:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:51:51 INFO - Installing distribute.............................................................................................................................................................................................done. 07:51:53 INFO - Installing pip.................done. 07:51:53 INFO - Return code: 0 07:51:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:51:53 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')]} 07:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:53 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')]} 07:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:53 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 0x7fd7e1484f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f32840>, '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 0x1e9f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', '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 07:51:53 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 07:51:53 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 07:51:53 INFO - Using env: {'DISPLAY': ':0', 07:51:53 INFO - 'HOME': '/home/cltbld', 07:51:53 INFO - 'LANG': 'en_US.UTF-8', 07:51:53 INFO - 'LANGUAGE': 'en_US:en', 07:51:53 INFO - 'LOGNAME': 'cltbld', 07:51:53 INFO - 'MAIL': '/var/mail/cltbld', 07:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:53 INFO - 'MOZ_NO_REMOTE': '1', 07:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:53 INFO - 'NO_EM_RESTART': '1', 07:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:51:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:51:53 INFO - 'SHELL': '/bin/bash', 07:51:53 INFO - 'SHLVL': '1', 07:51:53 INFO - 'TERM': 'linux', 07:51:53 INFO - 'TMOUT': '86400', 07:51:53 INFO - 'USER': 'cltbld', 07:51:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', 07:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:53 INFO - '_': '/tools/buildbot/bin/python'} 07:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:53 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 07:51:53 INFO - Cleaning up... 07:51:53 INFO - Return code: 0 07:51:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:51:53 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')]} 07:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:53 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')]} 07:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:53 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 0x7fd7e1484f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f32840>, '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 0x1e9f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', '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 07:51:53 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 07:51:53 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 07:51:53 INFO - Using env: {'DISPLAY': ':0', 07:51:53 INFO - 'HOME': '/home/cltbld', 07:51:53 INFO - 'LANG': 'en_US.UTF-8', 07:51:53 INFO - 'LANGUAGE': 'en_US:en', 07:51:53 INFO - 'LOGNAME': 'cltbld', 07:51:53 INFO - 'MAIL': '/var/mail/cltbld', 07:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:53 INFO - 'MOZ_NO_REMOTE': '1', 07:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:53 INFO - 'NO_EM_RESTART': '1', 07:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:51:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:51:53 INFO - 'SHELL': '/bin/bash', 07:51:53 INFO - 'SHLVL': '1', 07:51:53 INFO - 'TERM': 'linux', 07:51:53 INFO - 'TMOUT': '86400', 07:51:53 INFO - 'USER': 'cltbld', 07:51:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', 07:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:53 INFO - '_': '/tools/buildbot/bin/python'} 07:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:53 INFO - Downloading/unpacking psutil>=0.7.1 07:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:51:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:55 INFO - Installing collected packages: psutil 07:51:55 INFO - Running setup.py install for psutil 07:51:55 INFO - building 'psutil._psutil_linux' extension 07:51:55 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 07:51:55 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 07:51:55 INFO - building 'psutil._psutil_posix' extension 07:51:55 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 07:51:56 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 07:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:56 INFO - Successfully installed psutil 07:51:56 INFO - Cleaning up... 07:51:56 INFO - Return code: 0 07:51:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:51:56 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')]} 07:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:56 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')]} 07:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:56 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 0x7fd7e1484f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f32840>, '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 0x1e9f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', '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 07:51:56 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 07:51:56 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 07:51:56 INFO - Using env: {'DISPLAY': ':0', 07:51:56 INFO - 'HOME': '/home/cltbld', 07:51:56 INFO - 'LANG': 'en_US.UTF-8', 07:51:56 INFO - 'LANGUAGE': 'en_US:en', 07:51:56 INFO - 'LOGNAME': 'cltbld', 07:51:56 INFO - 'MAIL': '/var/mail/cltbld', 07:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:56 INFO - 'MOZ_NO_REMOTE': '1', 07:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:56 INFO - 'NO_EM_RESTART': '1', 07:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:51:56 INFO - 'PWD': '/builds/slave/test-pgo', 07:51:56 INFO - 'SHELL': '/bin/bash', 07:51:56 INFO - 'SHLVL': '1', 07:51:56 INFO - 'TERM': 'linux', 07:51:56 INFO - 'TMOUT': '86400', 07:51:56 INFO - 'USER': 'cltbld', 07:51:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', 07:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:56 INFO - '_': '/tools/buildbot/bin/python'} 07:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:51:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:51:58 INFO - Installing collected packages: mozsystemmonitor 07:51:58 INFO - Running setup.py install for mozsystemmonitor 07:51:58 INFO - Successfully installed mozsystemmonitor 07:51:58 INFO - Cleaning up... 07:51:58 INFO - Return code: 0 07:51:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:51:58 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')]} 07:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:58 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')]} 07:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:58 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 0x7fd7e1484f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f32840>, '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 0x1e9f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', '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 07:51:58 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 07:51:58 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 07:51:58 INFO - Using env: {'DISPLAY': ':0', 07:51:58 INFO - 'HOME': '/home/cltbld', 07:51:58 INFO - 'LANG': 'en_US.UTF-8', 07:51:58 INFO - 'LANGUAGE': 'en_US:en', 07:51:58 INFO - 'LOGNAME': 'cltbld', 07:51:58 INFO - 'MAIL': '/var/mail/cltbld', 07:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:58 INFO - 'MOZ_NO_REMOTE': '1', 07:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:58 INFO - 'NO_EM_RESTART': '1', 07:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 07:51:58 INFO - 'SHELL': '/bin/bash', 07:51:58 INFO - 'SHLVL': '1', 07:51:58 INFO - 'TERM': 'linux', 07:51:58 INFO - 'TMOUT': '86400', 07:51:58 INFO - 'USER': 'cltbld', 07:51:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', 07:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:58 INFO - '_': '/tools/buildbot/bin/python'} 07:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:51:58 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 07:51:58 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 07:51:58 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 07:51:58 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 07:51:58 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 07:51:58 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 07:52:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:00 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 07:52:00 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 07:52:00 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 07:52:00 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 07:52:00 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 07:52:00 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 07:52:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:52:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:00 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 07:52:00 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 07:52:00 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 07:52:00 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 07:52:00 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 07:52:00 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 07:52:00 INFO - Downloading docopt-0.6.1.tar.gz 07:52:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:01 INFO - Running setup.py install for blobuploader 07:52:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:52:01 INFO - Running setup.py install for requests 07:52:01 INFO - Running setup.py install for docopt 07:52:01 INFO - Successfully installed blobuploader requests docopt 07:52:01 INFO - Cleaning up... 07:52:01 INFO - Return code: 0 07:52:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:52: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')]} 07:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:01 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 0x7fd7e1484f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f32840>, '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 0x1e9f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', '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 07:52:01 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 07:52:01 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 07:52:01 INFO - Using env: {'DISPLAY': ':0', 07:52:01 INFO - 'HOME': '/home/cltbld', 07:52:01 INFO - 'LANG': 'en_US.UTF-8', 07:52:01 INFO - 'LANGUAGE': 'en_US:en', 07:52:01 INFO - 'LOGNAME': 'cltbld', 07:52:01 INFO - 'MAIL': '/var/mail/cltbld', 07:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:01 INFO - 'MOZ_NO_REMOTE': '1', 07:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:01 INFO - 'NO_EM_RESTART': '1', 07:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:01 INFO - 'SHELL': '/bin/bash', 07:52:01 INFO - 'SHLVL': '1', 07:52:01 INFO - 'TERM': 'linux', 07:52:01 INFO - 'TMOUT': '86400', 07:52:01 INFO - 'USER': 'cltbld', 07:52:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', 07:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:01 INFO - '_': '/tools/buildbot/bin/python'} 07:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:01 INFO - Running setup.py (path:/tmp/pip-zLoyD0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:01 INFO - Running setup.py (path:/tmp/pip-EzIchf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:01 INFO - Running setup.py (path:/tmp/pip-ZKTMYF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:02 INFO - Running setup.py (path:/tmp/pip-5Jr2KZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:02 INFO - Running setup.py (path:/tmp/pip-TNZMU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:02 INFO - Running setup.py (path:/tmp/pip-Kr_B4a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:02 INFO - Running setup.py (path:/tmp/pip-edemjK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:02 INFO - Running setup.py (path:/tmp/pip-7aWGIM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:02 INFO - Running setup.py (path:/tmp/pip-9ggbDD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:02 INFO - Running setup.py (path:/tmp/pip-DLFmaq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:02 INFO - Running setup.py (path:/tmp/pip-ZdXbQT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:02 INFO - Running setup.py (path:/tmp/pip-dXMgDJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:02 INFO - Running setup.py (path:/tmp/pip-v12yL9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:02 INFO - Running setup.py (path:/tmp/pip-SOLnbl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:02 INFO - Running setup.py (path:/tmp/pip-0rjpwf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:02 INFO - Running setup.py (path:/tmp/pip-LuRb1G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:02 INFO - Running setup.py (path:/tmp/pip-3hMicF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:03 INFO - Running setup.py install for manifestparser 07:52:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:52:03 INFO - Running setup.py install for mozcrash 07:52:03 INFO - Running setup.py install for mozdebug 07:52:03 INFO - Running setup.py install for mozdevice 07:52:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:52:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:52:03 INFO - Running setup.py install for mozfile 07:52:03 INFO - Running setup.py install for mozhttpd 07:52:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:52:03 INFO - Running setup.py install for mozinfo 07:52:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:52:03 INFO - Running setup.py install for mozInstall 07:52:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:52:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:52:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:52:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:52:03 INFO - Running setup.py install for mozleak 07:52:03 INFO - Running setup.py install for mozlog 07:52:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Running setup.py install for moznetwork 07:52:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Running setup.py install for mozprocess 07:52:04 INFO - Running setup.py install for mozprofile 07:52:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Running setup.py install for mozrunner 07:52:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Running setup.py install for mozscreenshot 07:52:04 INFO - Running setup.py install for moztest 07:52:04 INFO - Running setup.py install for mozversion 07:52:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:04 INFO - Cleaning up... 07:52:04 INFO - Return code: 0 07:52:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:04 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 0x7fd7e1484f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f32840>, '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 0x1e9f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', '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 07:52:04 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 07:52:04 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 07:52:04 INFO - Using env: {'DISPLAY': ':0', 07:52:04 INFO - 'HOME': '/home/cltbld', 07:52:04 INFO - 'LANG': 'en_US.UTF-8', 07:52:04 INFO - 'LANGUAGE': 'en_US:en', 07:52:04 INFO - 'LOGNAME': 'cltbld', 07:52:04 INFO - 'MAIL': '/var/mail/cltbld', 07:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:04 INFO - 'MOZ_NO_REMOTE': '1', 07:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:04 INFO - 'NO_EM_RESTART': '1', 07:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:04 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:04 INFO - 'SHELL': '/bin/bash', 07:52:04 INFO - 'SHLVL': '1', 07:52:04 INFO - 'TERM': 'linux', 07:52:04 INFO - 'TMOUT': '86400', 07:52:04 INFO - 'USER': 'cltbld', 07:52:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', 07:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:04 INFO - '_': '/tools/buildbot/bin/python'} 07:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:05 INFO - Running setup.py (path:/tmp/pip-XTsDYF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:05 INFO - Running setup.py (path:/tmp/pip-wEG88C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:05 INFO - Running setup.py (path:/tmp/pip-MRuEjI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:05 INFO - Running setup.py (path:/tmp/pip-AwpsSp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:05 INFO - Running setup.py (path:/tmp/pip-g6QA1a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:05 INFO - Running setup.py (path:/tmp/pip-XlLtpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:05 INFO - Running setup.py (path:/tmp/pip-DaDvIq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:05 INFO - Running setup.py (path:/tmp/pip-YeItyV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:05 INFO - Running setup.py (path:/tmp/pip-UH9sXX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:05 INFO - Running setup.py (path:/tmp/pip-3Ho2Br-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:05 INFO - Running setup.py (path:/tmp/pip-SAuRr0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:05 INFO - Running setup.py (path:/tmp/pip-J6nP5L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:05 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)) 07:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:05 INFO - Running setup.py (path:/tmp/pip-KpYKUU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:06 INFO - Running setup.py (path:/tmp/pip-rljQDk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:06 INFO - Running setup.py (path:/tmp/pip-DRZs6p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:06 INFO - Running setup.py (path:/tmp/pip-mRAX3d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:06 INFO - Running setup.py (path:/tmp/pip-PlVgDl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:06 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)) 07:52:06 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)) 07:52:06 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)) 07:52:06 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)) 07:52:06 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)) 07:52:06 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)) 07:52:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:08 INFO - Downloading blessings-1.6.tar.gz 07:52:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:08 INFO - Installing collected packages: blessings 07:52:08 INFO - Running setup.py install for blessings 07:52:08 INFO - Successfully installed blessings 07:52:08 INFO - Cleaning up... 07:52:08 INFO - Return code: 0 07:52:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:52:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:52:08 INFO - Reading from file tmpfile_stdout 07:52:08 INFO - Current package versions: 07:52:08 INFO - argparse == 1.2.1 07:52:08 INFO - blessings == 1.6 07:52:08 INFO - blobuploader == 1.2.4 07:52:08 INFO - docopt == 0.6.1 07:52:08 INFO - manifestparser == 1.1 07:52:08 INFO - mozInstall == 1.12 07:52:08 INFO - mozcrash == 0.16 07:52:08 INFO - mozdebug == 0.1 07:52:08 INFO - mozdevice == 0.48 07:52:08 INFO - mozfile == 1.2 07:52:08 INFO - mozhttpd == 0.7 07:52:08 INFO - mozinfo == 0.9 07:52:08 INFO - mozleak == 0.1 07:52:08 INFO - mozlog == 3.1 07:52:08 INFO - moznetwork == 0.27 07:52:08 INFO - mozprocess == 0.22 07:52:08 INFO - mozprofile == 0.28 07:52:08 INFO - mozrunner == 6.11 07:52:08 INFO - mozscreenshot == 0.1 07:52:08 INFO - mozsystemmonitor == 0.0 07:52:08 INFO - moztest == 0.7 07:52:08 INFO - mozversion == 1.4 07:52:08 INFO - psutil == 3.1.1 07:52:08 INFO - requests == 1.2.3 07:52:08 INFO - wsgiref == 0.1.2 07:52:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:52: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')]} 07:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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/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 0x7fd7e1484f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f32840>, '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 0x1e9f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', '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 07:52:08 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 07:52:08 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 07:52:08 INFO - Using env: {'DISPLAY': ':0', 07:52:08 INFO - 'HOME': '/home/cltbld', 07:52:08 INFO - 'LANG': 'en_US.UTF-8', 07:52:08 INFO - 'LANGUAGE': 'en_US:en', 07:52:08 INFO - 'LOGNAME': 'cltbld', 07:52:08 INFO - 'MAIL': '/var/mail/cltbld', 07:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:08 INFO - 'MOZ_NO_REMOTE': '1', 07:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:08 INFO - 'NO_EM_RESTART': '1', 07:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:08 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:08 INFO - 'SHELL': '/bin/bash', 07:52:08 INFO - 'SHLVL': '1', 07:52:08 INFO - 'TERM': 'linux', 07:52:08 INFO - 'TMOUT': '86400', 07:52:08 INFO - 'USER': 'cltbld', 07:52:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', 07:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:08 INFO - '_': '/tools/buildbot/bin/python'} 07:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:08 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)) 07:52:08 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)) 07:52:08 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)) 07:52:08 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)) 07:52:08 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)) 07:52:08 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)) 07:52:08 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)) 07:52:08 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)) 07:52:08 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)) 07:52:08 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)) 07:52:08 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)) 07:52:08 INFO - Cleaning up... 07:52:08 INFO - Return code: 0 07:52:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:52: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')]} 07:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e1484f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f32840>, '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 0x1e9f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', '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 07:52:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:52:08 INFO - Using env: {'DISPLAY': ':0', 07:52:08 INFO - 'HOME': '/home/cltbld', 07:52:08 INFO - 'LANG': 'en_US.UTF-8', 07:52:08 INFO - 'LANGUAGE': 'en_US:en', 07:52:08 INFO - 'LOGNAME': 'cltbld', 07:52:08 INFO - 'MAIL': '/var/mail/cltbld', 07:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:08 INFO - 'MOZ_NO_REMOTE': '1', 07:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:08 INFO - 'NO_EM_RESTART': '1', 07:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:08 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:08 INFO - 'SHELL': '/bin/bash', 07:52:08 INFO - 'SHLVL': '1', 07:52:08 INFO - 'TERM': 'linux', 07:52:08 INFO - 'TMOUT': '86400', 07:52:08 INFO - 'USER': 'cltbld', 07:52:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', 07:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:08 INFO - '_': '/tools/buildbot/bin/python'} 07:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:08 INFO - Downloading/unpacking jsonschema 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 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 07:52:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:10 INFO - Downloading/unpacking functools32 (from jsonschema) 07:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:10 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:11 INFO - warning: no files found matching '*.txt' 07:52:11 INFO - no previously-included directories found matching 'build' 07:52:11 INFO - no previously-included directories found matching 'dist' 07:52:11 INFO - no previously-included directories found matching '.git*' 07:52:11 INFO - Installing collected packages: jsonschema, functools32 07:52:11 INFO - Running setup.py install for functools32 07:52:11 INFO - warning: no files found matching '*.txt' 07:52:11 INFO - no previously-included directories found matching 'build' 07:52:11 INFO - no previously-included directories found matching 'dist' 07:52:11 INFO - no previously-included directories found matching '.git*' 07:52:11 INFO - Successfully installed jsonschema functools32 07:52:11 INFO - Cleaning up... 07:52:11 INFO - Return code: 0 07:52:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:52: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')]} 07:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:11 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 0x7fd7e1484f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f32840>, '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 0x1e9f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', '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 07:52:11 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 07:52:11 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 07:52:11 INFO - Using env: {'DISPLAY': ':0', 07:52:11 INFO - 'HOME': '/home/cltbld', 07:52:11 INFO - 'LANG': 'en_US.UTF-8', 07:52:11 INFO - 'LANGUAGE': 'en_US:en', 07:52:11 INFO - 'LOGNAME': 'cltbld', 07:52:11 INFO - 'MAIL': '/var/mail/cltbld', 07:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:11 INFO - 'MOZ_NO_REMOTE': '1', 07:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:11 INFO - 'NO_EM_RESTART': '1', 07:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:11 INFO - 'SHELL': '/bin/bash', 07:52:11 INFO - 'SHLVL': '1', 07:52:11 INFO - 'TERM': 'linux', 07:52:11 INFO - 'TMOUT': '86400', 07:52:11 INFO - 'USER': 'cltbld', 07:52:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', 07:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:11 INFO - '_': '/tools/buildbot/bin/python'} 07:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:11 INFO - Downloading/unpacking flake8 07:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:52:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:52:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 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 07:52:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:52:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:13 INFO - no previously-included directories found matching 'docs/_build' 07:52:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:52:14 INFO - Running setup.py install for pep8 07:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:14 INFO - no previously-included directories found matching 'docs/_build' 07:52:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:52:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:52:14 INFO - Cleaning up... 07:52:14 INFO - Return code: 0 07:52:14 INFO - Running post-action listener: _resource_record_post_action 07:52:14 INFO - Running post-action listener: _start_resource_monitoring 07:52:14 INFO - Starting resource monitoring. 07:52:14 INFO - ##### 07:52:14 INFO - ##### Running install step. 07:52:14 INFO - ##### 07:52:14 INFO - Running pre-action listener: _resource_record_pre_action 07:52:14 INFO - Running main action method: install 07:52:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:52:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:52:14 INFO - Reading from file tmpfile_stdout 07:52:14 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:52:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:52:14 INFO - Reading from file tmpfile_stdout 07:52:14 INFO - Output received: 07:52:14 INFO - Usage: mozinstall [options] installer 07:52:14 INFO - Options: 07:52:14 INFO - -h, --help show this help message and exit 07:52:14 INFO - -d DEST, --destination=DEST 07:52:14 INFO - Directory to install application into. [default: 07:52:14 INFO - "/builds/slave/test-pgo"] 07:52:14 INFO - --app=APP Application being installed. [default: firefox] 07:52:14 INFO - mkdir: /builds/slave/test-pgo/build/application 07:52:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:52:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:52:30 INFO - Reading from file tmpfile_stdout 07:52:30 INFO - Output received: 07:52:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:52:30 INFO - Running post-action listener: _resource_record_post_action 07:52:30 INFO - ##### 07:52:30 INFO - ##### Running run-tests step. 07:52:30 INFO - ##### 07:52:30 INFO - Running pre-action listener: _resource_record_pre_action 07:52:30 INFO - Running main action method: run_tests 07:52:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:52:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:52:30 INFO - Python 2.7.3 07:52:30 INFO - Return code: 0 07:52:30 INFO - grabbing minidump binary from tooltool 07:52:30 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')]} 07:52:30 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 0x1f32840>, '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 0x1e9f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:52:30 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 07:52:30 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 07:52:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:52:30 INFO - Return code: 0 07:52:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:52:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:52:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:52:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:52:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:52:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:52:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:52:31 INFO - Return code: 0 07:52:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:52:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:52:31 INFO - Using env: {'DISPLAY': ':0', 07:52:31 INFO - 'HOME': '/home/cltbld', 07:52:31 INFO - 'LANG': 'en_US.UTF-8', 07:52:31 INFO - 'LANGUAGE': 'en_US:en', 07:52:31 INFO - 'LOGNAME': 'cltbld', 07:52:31 INFO - 'MAIL': '/var/mail/cltbld', 07:52:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:52:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:31 INFO - 'MOZ_NO_REMOTE': '1', 07:52:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:31 INFO - 'NO_EM_RESTART': '1', 07:52:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:31 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:52:31 INFO - 'SHELL': '/bin/bash', 07:52:31 INFO - 'SHLVL': '1', 07:52:31 INFO - 'TERM': 'linux', 07:52:31 INFO - 'TMOUT': '86400', 07:52:31 INFO - 'USER': 'cltbld', 07:52:31 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019', 07:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:31 INFO - '_': '/tools/buildbot/bin/python'} 07:52:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:52:31 INFO - mozversion application_buildid: 20160120073402 07:52:31 INFO - mozversion application_changeset: 6764bc656c1d146962d53710d734c2ac87c2306f 07:52:31 INFO - mozversion application_display_name: Nightly 07:52:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:52:31 INFO - mozversion application_name: Firefox 07:52:31 INFO - mozversion application_remotingname: firefox 07:52:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:52:31 INFO - mozversion application_vendor: Mozilla 07:52:31 INFO - mozversion application_version: 46.0a1 07:52:31 INFO - mozversion platform_buildid: 20160120073402 07:52:31 INFO - mozversion platform_changeset: 6764bc656c1d146962d53710d734c2ac87c2306f 07:52:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:52:31 INFO - mozversion platform_version: 46.0a1 07:52:31 INFO - using testdate: 1453391551 07:52:31 INFO - actual date: 1453391551 07:52:31 INFO - starting webserver on 'localhost:46818' 07:52:31 INFO - SUITE-START | Running 3 tests 07:52:31 INFO - TEST-START | dromaeo_css 07:52:31 INFO - operating with platform_type : linux_ 07:52:31 INFO - Initialising browser for dromaeo_css test... 07:52:32 INFO - TEST-INFO | started process 28884 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKjh31c/profile http://localhost:46818/getInfo.html) 07:52:36 INFO - PROCESS | 28884 | __metrics Screen width/height:1600/1200 07:52:36 INFO - PROCESS | 28884 | colorDepth:24 07:52:36 INFO - PROCESS | 28884 | Browser inner width/height: 1024/697 07:52:36 INFO - PROCESS | 28884 | __metrics 07:52:36 INFO - PROCESS | 28884 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:52:36 INFO - PROCESS | 28884 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:52:37 INFO - TEST-INFO | 28884: exit 0 07:52:37 INFO - Browser initialized. 07:52:37 INFO - Running cycle 1/1 for dromaeo_css test... 07:52:37 INFO - TEST-INFO | started process 28978 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKjh31c/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:49 INFO - PROCESS | 28978 | RSS: Main: 149024768 07:52:49 INFO - PROCESS | 28978 | 07:53:40 INFO - PROCESS | 28978 | 1453391620073 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] 07:55:48 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:46818/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46818/tests/dromaeo/cssquery-ext.html) 07:55:49 INFO - PROCESS | 28978 | RSS: Main: 293363712 07:55:49 INFO - PROCESS | 28978 | 07:58:52 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:46818/tests/dromaeo/cssquery-ext.html (next: http://localhost:46818/tests/dromaeo/cssquery-jquery.html) 07:58:52 INFO - PROCESS | 28978 | RSS: Main: 227020800 07:58:52 INFO - PROCESS | 28978 | 08:01:54 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:46818/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46818/tests/dromaeo/cssquery-mootools.html) 08:01:55 INFO - PROCESS | 28978 | RSS: Main: 238170112 08:01:55 INFO - PROCESS | 28978 | 08:04:57 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:46818/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46818/tests/dromaeo/cssquery-prototype.html) 08:04:57 INFO - PROCESS | 28978 | RSS: Main: 209674240 08:04:57 INFO - PROCESS | 28978 | 08:08:00 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:46818/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46818/tests/dromaeo/cssquery-yui.html) 08:08:00 INFO - PROCESS | 28978 | RSS: Main: 216821760 08:08:00 INFO - PROCESS | 28978 | 08:11:03 INFO - PROCESS | 28978 | Cycle 1(1): loaded http://localhost:46818/tests/dromaeo/cssquery-yui.html (next: http://localhost:46818/tests/dromaeo/cssquery-dojo.html) 08:11:04 INFO - PROCESS | 28978 | RSS: Main: 293302272 08:11:04 INFO - PROCESS | 28978 | 08:11:04 INFO - PROCESS | 28978 | __start_tp_report 08:11:04 INFO - PROCESS | 28978 | _x_x_mozilla_page_load 08:11:04 INFO - PROCESS | 28978 | _x_x_mozilla_page_load_details 08:11:04 INFO - PROCESS | 28978 | |i|pagename|runs| 08:11:04 INFO - PROCESS | 28978 | |0;dojo.html;3117.7505799536034;3155.447796635588;3198.8880389186384;3200.487921932491;3223.564818749469;5146.948530514703;5213.504717051874;5248.606354523412;5252.264682944386;5288.101022826119;5159.071367153911;5210.843674689756;5211.817586384468;5213.296205012322;5279.1817268323475;4738.573528382436;4760.190767569504;4793.832215872445;4821.614270858323;4909.459959404463;498.75941221697593;4697.295405689157;4766.856994290177;4776.546228108324;4843.564079232869;4749.833755818547;4771.594414474774;4772.76136193189;4780.37855078841;4780.569748722614;4687.6249900007915;4755.476897541268;4761.785719642625;4767.642426818003;4775.71345719258;4692.53074692528;4731.976340118277;4747.216709242971;4747.264174053027;4783.856484305476;4965.453800081988;4979.47715489872;4980;4980.078685443204;5010.073136469765;5395.0558652236095;5473.781048758045;5570.164475328693;5588.692621905793;5674.943250567483;5599.6640201587625;5631.71841407928;5651.4348565143155;5657.971710141464;5659.971700141514;5214.478552144755;5281.339832520935;5290.074237008508;5295;5298.947010529922;5579.163125531203;5667.064934285797;5691.03252447085;5715.714214289269;5792.304923409218;5480.205370221295;5480.3971563128825;5486.1222204447895;5488.396276409591;5491.36849262332;5452.427495113036;5562.666240025612;5566.55467562594;5574.581906356958;5583.497485226349;5500.1749737539685;5547.195656629847;5589.077802162597;5603.579731520153;5640.887182256414;5586.35756887955;5598.524125449301;5604.747786349542;5604.775808967595;5607.130894711327;4316.266234740102;4387.210302145644;4388.210122178039;4395;4444.488883778342;3876.8449262029203;3897.6492115709157;3905.8047097645003;3934.4688467057154;3964.9207015860097;5086.440491545927;5103.974480127576;5117.513836185631;5141.794328226829;5193.143131383355;5517.062099443105;5540.085885828793;5541.33503979525;5587.888242235133;5595.160725891149;5121.8719532012;5163.044836705221;5170.715610641376;5187.299714538564;5233.450487698737;4780.1873681474235;4809;4810.855674329776;4811.254255590389;4846.29728689338;5697.230873832063;5709.714514274353;5719.914201286901;5765.04876695349;5775.422457754191;5601.60788744784;5602.411746766531;5603.747831347518;5610.915836262541;5630.183623374506;5790.478856902899;5815.883682326415;5816.709164541671;5818.534517238695;5838.241028666416;5427.864303392446;5509.228707980806;5546.306711661043;5548.667079975215;5631.802886898939;5535.750891209825;5541.612087153861;5545.556355491632;5548.112302031655;5563.7774489019985;5370.865728356823;5419.945800541944;5436.809711660073;5443.836684899459;5497.175423686319;5358.437364076872;5439.075357189208;5525.751341189736;5600.187972744011;5608.130739735348;5457.69982650958;5461.426550212171;5469.726513674221;5469.890602188014;5493.587980901369;5548.667079975215;5560.36055853582;5565.026120428828;5567.66594004361;5577.693226872561;5264.1577347625725;5359.437259087739;5386.13821788512;5479.0959491683425;5497.505224529652 08:11:04 INFO - PROCESS | 28978 | |1;ext.html;532.9546988505977;540.4622400711293;556.2101815422105;565.7256230728096;581.1602234770755;28254.15237542872;29114.563281550767;36293.63706362936;36341;36412.27175456489;39284.607153928526;39500.60499395005;39575.40636890442;39661.801690991575;39748.99999999993;8259.91740082599;8425.662973481054;8451.239388455038;8452.661893524251;8454.281386082159;8273.131321211276;8413.579321033954;8424.368172387065;8429.95785021077;8430.747077587683;8518.446300990416;8595.484270943733;8598.140185981414;8610;8610.741677749646;8324.29243514302;8398.412111152222;8401;8409.159084091603;8444.197801208875;8301.916980830174;8454.661813527451;8479.152084791533;8488.575571221414;8509.531975741333;39151.41272880909;39369.21261574752;39604.40593391102;39650.20699586021;39672.80163599164;3192.1859925719027;3212.14878057315;3284.96715032849;3285.5071739239065;3384.8984530464127;29557.70442295571;29763;30109.397812043637;30444.238894027603;30855;3876;3928.5482169550583;3949.0917089069676;4001.779902105383;4021.4973128358956;256797;257467.99999999814;258134;258412;258444;51365;52802.73598632059;56576;57106.14340784892;58504;54393.45606543884;54635;54730;54917;54925.85963824677;14016.509422170175;14125;14134.929325353307;14142.50501232452;14201.076929999517;9940.652077177409;10170.186385089175;10174.4912754362;10480.895191048145;10721.571137154426;18441.907790460962;18768.53078673044;18768.53078673044;18817.15322810477;18888.622227555374;6985.406240469515;7257.802462593719;7348.926510734931;7369.441197334377;7461.962690186623;933.3699752666922;943.4527973775193;966.5264020629841;1027.9588816447408;1100.691806294223;28356.574651380244;28480.430391392056;28494.857525712654;28855.278618034718;28936.131916042552;1000.8098461292477;1020.806046851096;1026.6765968719828;1042.9895701043044;1137.3630766770634;12904.419301131284;13259.66850828737;13308.6672833178;13382.063255572211;13444.596662100153;341467;344768;345356;345719;346481;52637.2104418434;52896.73551632217;52917.2062419064;52971;52973.470265296855;1214.1440284599337;1238.1704258147063;1244.147758785235;1318.6769341260162;1352.1819299323963;22992.310230693107;23394.76605233994;23429.41426464352;23552.882235588713;23611.173608923604;39269.6073039266;39640.2071958565;39685.801570991964;39685.801570991964;43122;228660;308316;313790;314634;314951;28496.43007139887;29071.854640727506;29105.41789164247;29132;29147;39657.40513892352;42827.143457130056;43078.569214307456;43467;43592;36638.267234655694;36742;37538;37660.62339376681;38311.80844095762;37032.62967370292;37368.81315593513;37538.81230593829;37583;37919.43120853134;36361.09097272589;36519.63480365162;36636.81681591575;36651.816740916125;36964.260714785014;29093.41813163767;30231.848840756535;30620.234494137825;30620.387592248477;30666.080017599506;23699.763002369757;24638;24873.253802385956;25089.372765681004;25094.62358064667 08:11:04 INFO - PROCESS | 28978 | |2;jquery.html;363.15385152594456;363.892651667758;365.31685747651886;366.9064388580913;368.9723270754694;13580.456781728744;13586.728265434685;15614.453494127707;17119.57201069974;18240.087995600217;15257.465988690397;15446.150461724601;15856.3657453702;15902.045877247345;15913.602159946007;5233.18885572735;5456.208849716789;5458.61789674723;5462.562994960394;5465.207544905987;3994.560598334181;4123.525794533622;5338.599605029638;5429.429909859467;5852.151438041481;5719.542436605082;5970.761169553212;6021.578489505737;6030.487408570277;6038.275406951172;5933.821985340425;5938.851528711773;5953.970230148865;5956.106584012389;5960.254968128984;5081.79672813087;5103.311053007834;5164.096283150471;5172.172452407634;5240.842774716764;18334.266629334812;19227.13477893484;20004.89997550003;20253.696194557095;20279.493012674655;2133.125418578391;2175.945601359979;2324.4769926766344;2399.7763935473517;2613.4773045391;12533.304062347142;12534.81197782034;12538.937305313415;12580.748385032248;12891.677708057374;1649;1730.1522254095528;1742.0941110622532;1782.27817733818;1810.4387639831693;50237.74881125571;51299.74350128225;52129.73935130338;52132.47867521352;52494.73752631251;9539.713808585753;9681.806363872684;9738.123568878835;9801.313908026512;9923.305368624127;12762.744745105047;12908.935455322664;12916.612501624966;12928.353582320846;12929.418176182095;7146.964265178641;7201.243869393743;7203.351698347174;7214.458915581353;7237.167725711611;6788.2193547742645;6866.759663411756;6869.656517174121;6935.54918930278;6938.444924406035;5623.718814059281;5679.545636349082;5755.9424405756245;5790.276215473066;5805.767769289266;1651.7604947282578;1714.545645403969;1756.394044054799;1774.1484087637748;1800.666876627802;924.191332583989;927.8561822917459;928.1924725488868;930.3719989007393;1051.9000694933968;12969;14969.700605987819;15197.568389057698;15472.845271547365;15960.920195399181;887.933404994628;919.4023884475012;921.4931787516839;947.9052094790466;983.3755565215996;9236.953815231016;9251.814963700688;9496.287778416647;9671.468069256258;9779.951100244596;537917;550735;551879;556037;559574;70266;71110.64444677744;71213.64393178104;71452.64273678599;71582.28417715861;1109.4730003248553;1109.517359948425;1115.1134847796022;1118.8196452742272;1128.3173679923527;14814.703705925605;14986.47547335838;15175.16536590498;15288;15324.923375383052;32777.67222327746;32812.1796955078;33056;33417.49873751944;33605.663943360254;42334.57665423306;42700;42849.571504284555;42983.78508107439;44291.33562996493;6938.965305173442;6987.475939304471;7173.820654483679;7313.780586582411;7413.369863561442;7325.926740732738;9195.724128276162;9727;10778.784424311312;11268.098552115647;8570.314374850122;9118.133777291147;9238.260939124719;9263.907360926574;9296.209822164921;9196.632134714537;9603.471809050568;9676.564554595201;10162.23783216247;10181.796364072528;7205.423566114803;8918.73243802687;9126.133017363605;9356.672516462164;9698.36960597559;7327.340539351484;7521.0974683038385;7560.773176804704;7570.296683246446;7572.091349038151;9445.527723613654;9482.95687474391;9508;9585.472798996123;9680.370775899544 08:11:04 INFO - PROCESS | 28978 | |3;mootools.html;1293.3727142335972;1440.5174266620684;1456.1845366594705;1489.5978085916802;1570.5366916759556;7103.112110986127;7709.961450192748;7864.921350786491;7879.212078792118;7896.210378962101;7701.268379503952;7885.842283154333;7886.526808391501;7887.645055972481;7898.052233731946;1991.0741505200078;2031.3195079648335;2036.1549956767924;2306.1006207579057;2337.4039619896903;1934.1199754111915;2301.827362947777;2356.8922606375063;2357.363511851799;2360.3745007573007;2245.9775402246014;2272.556851413975;2281.190177486993;2281.2129815213807;2301.2290882554366;2276.4422716434415;2304.101400453816;2308.8730119843403;2309.9538009239723;2313.5372925414986;2289.0843662534953;2290.725112986452;2295.7933785959344;2298.402415371999;2304.4584522637165;7952.880706789403;8024.598770061532;8026.759197224034;8028;8036;4877.5366340197625;4937.407511098655;4952.653314268003;4962.106820772259;4988.90022199554;3052.9389412211854;3084.2906131589634;3154.858031388593;3207.8556464959133;3211.7912335698106;1047.350642601592;1056.1550759392455;1792.103948025987;1812.7280907863794;1818.7817461904524;11064.889351106547;11129;11134.832977505344;11151.665450036431;11162.107031437465;4297.355396690459;4313.84901528445;4327.156204540084;4362.17118747437;4483.50681425043;8961.59672814725;9009;9038.502882341534;9058.230050445654;9060.093990601019;4926.655134140576;5010.974945125324;5035.295058691786;5041.546260836542;5044.772985215674;4593.035462552834;4626.398568186114;4637.46669133054;4643.8374656886845;4644.8374306899095;3412.931741365159;3450.810205438725;3522.947155792665;3628.310620982005;3628.546431696038;1101.5703875488566;1122.6126986189752;1127.932324060559;1150.8849115088424;1156.7744289863397;1255.4727014653868;1286.3246795432474;1300.2133709105856;1324.6224825924564;1327.482281910056;7311.67097480604;7390.445716571171;7768.53388796674;7770.766876993699;7773;1069.7325668582855;1082.8267477203767;1083.0577397663926;1084.7450849050467;1105.6682995101437;5882.941170588325;5969.253843269591;5975.043992961192;5979.79070732531;5980.461758441761;9507.619695212252;9642.42145471274;9883.209343252522;9938.453385063747;9947.104760571583;9701.175400091071;9711.27165462579;9718.854217186748;9742.269329800152;9848.704538863845;7058.364747172779;7227.530210536298;7229.638518074075;7240.312170343809;7456.47804653669;7475.925240747523;7478.70085196586;7604.42966777505;7620.771376858703;7629.2370762923265;8663;8694.434861733967;8710.651573936972;8717.171868672465;8846.513441760764;9089.59096840657;9145.039770823967;9283.257339412696;9296.302777291865;9318.394304370466;7166.89249661266;7211.531250468703;7278.09023872016;7296.562206267641;7304.671289791866;6895.689693963684;6916.896246556205;7594.050743657043;7850.646720897459;7964.522128672298;7002.75490357835;7035;7122.928770712227;7280.635968201463;7297.379722723628;6885.139357580302;7018.894716579153;7245.420366370783;7359.190489046094;7378;7195.280471952763;7251.41988640918;7265.636718164176;7268.89096663561;7287;6230.06549017651;6375.394337537927;6382;6383.6808159592765;6388.4569811566535;6678.065070890177;6735.326467353226;6736.797896063126;6739.764108256188;6742.123523942052 08:11:04 INFO - PROCESS | 28978 | |4;prototype.html;338.7865644643874;344.27014728775004;348.06197298281137;348.23909757180576;353.173573837221;5730.6275092118985;5813.2442782438275;5845.357010728827;5959.225300710907;5963.135345374918;5678.943210567893;5806;5809.04150815115;5821.359650438449;5827.970860145704;4527.2530032544755;4534.455865296169;4534.9319760203625;4536.7504787236685;4538.296564032572;4350.869473915787;4446.177457170417;4459.620932220765;4566.086782643468;4569.268916973285;4507.459104907416;4507.842225522108;4526.4836279846295;4538.954610453886;4553.430821147356;4513.232750432418;4531.796069176911;4545.818167273305;4547.226971414867;4556.589906908394;4010.3783913493453;4029.5366032906004;4035;4037.2732908076537;4040.393940908858;5423.267858839085;5549.278593782823;5559.360673522557;5563.193336966117;5573.888522229533;5238.947610523922;5246.108161612535;5249.553787928031;5250.002499525078;5255.474452554752;5931.110333450017;6275.497960163176;6275.937240627627;6284.18305620271;6285.214348206474;4214.967333003403;4242.00312926462;4276.273033584298;4282.550332215135;4284.464441944757;6375.808725738235;6444.935550644481;6447.484201263887;6450.354964503512;6482.092507049017;4431.468223813099;4437.06821567468;4441.156180325728;4443.044745379759;4475.373447717322;4359;4504.977475112603;4505.256632655575;4506.053728717006;4508.301213311942;5161.741912904415;5181.922271165936;5202.24567437727;5204.297419848272;5205.24523944026;6259.6870156492;6273.247210334698;6277.1525844010475;6283.403076707706;6293.96853015732;1552.9301181446863;1599.720048991422;1600.407849095842;1600.9919950400174;1601.9839801601836;1017.6133069433567;1040.6721882606955;1068.572570971602;1074.248026381536;1084.3060441317564;5872.647641141545;5878.5003274721275;5886.793962211302;5887.028640274307;5896.262967129109;6371.840703982345;6409.711562979677;6426.325235850262;6438.517111216677;6439.452646525097;5907.4683278505145;5910.940890591039;5917.142014407887;5919.526437884959;5934.347221805598;3380.273241253093;3482.425399809054;3488.4418493040994;3490.6334834842482;3497.7726447780815;6737.629430381376;6744.898826517606;6748.561343512656;6749.190097188369;6749.898751518731;6615.17310336208;6634.677862748;6634.767783127568;6634.834129146713;6636.535442518977;6532.902006469907;6717;6731.663416829139;6732.764353247613;6739.393454589209;6218.409251121137;6385.425311721968;6459.935400645933;6467.126937863328;6473.320301368289;6275.8075965566395;6382.329855365306;6397.6481293529305;6415.775447859489;6423.807285781434;6704.865902681821;6710;6711.362420570038;6722.361375669304;6729;4348.891277718082;4426.889327766831;4458.487273963536;4459.375687403831;4460.710053846489;6405.8718825624155;6452.612843229421;6457.160569125984;6457.354264573505;6464.288928217987;6258.561900666909;6315.115883776183;6320.399562041599;6322;6326.3041065483685;6193.194884664965;6239.220097487814;6290.874182516415;6299.11812346281;6308.27454842699;6175.660338681416;6187.102870083722;6191.288001879841;6191.473724733448;6195.473384762346;6321.367863213826;6327.525435592257;6330.936690633035;6331.430171284606;6338.651374174465;6075.969620151871;6167.414095660905;6186.443220110212;6190.1952746142715;6196.597221180609 08:11:04 INFO - PROCESS | 28978 | |5;yui.html;714.1965289049818;746.0264355016708;815.9510429374238;830.8047608811928;839.7690635075354;13425.32873356332;13640.181589104648;13652.522161724317;13662.248576328298;13673.794893076612;12611.936940315309;12651.620451386472;12656.240625562472;12664.746705065892;12672.239665620069;646.7122130651862;656.2092678322633;774.4230548241568;787.9921200787991;793.2781169136088;788.5032429569392;791.5448617045193;791.6437603078609;793.1434051224693;794.2613369566301;681.2540268406087;823.7322870067222;825.6202147012382;826;826.8428998490298;682.0110839283035;816.5141740664295;825.5583262954351;826.1078035721406;828.035338830262;610.346928786199;610.9419605137549;611.2023808929346;612.5283531680626;613.3835495327168;13021.153625014344;13060.673483162902;13088.411021504055;13092.345382730826;13109.41007654658;12412.317322547256;12775.936120319431;12839.358032098358;13000.414981325863;13043.088150260233;10314.226433017553;10400.895991040145;10406;10505.52725127371;10602.46987650622;3485.268093700326;3578.4632305154173;3620.9094772630633;3723.7765734056043;3758.5489741231227;44154;44457.11085778266;44518;45331;45941.08117837658;9567.952160239294;9600.183984361267;9641.517924103768;9703.66037188695;9763.902360976299;17664.823351766318;17873.19570619325;17900.194491247927;17941;17968;7671.923280767232;7733;7817.648205830751;7869.763907082796;8008.919910800817;4238.809253583596;4343.131373725268;4372.519022907478;4449.087936972913;4454.665900057444;3050.6491753448195;3078.4766589679807;3097.519884417919;3102.736267417295;3147.1660010097344;582.2430839908103;588.8145234251197;592.0231617830614;593.5993204586887;594.6164723753242;523.6700878446554;566.145120867493;636.700750647195;677.4546490075438;686.27255109584;8550.250817340038;8599.818067315133;8682.86975695365;8714.912850871537;8752.606132724042;534.8235082422791;628.996855015722;653.3792896748108;661.3584822721951;679.7994591595392;3788.905277368088;4019.2162528307285;4060.8630082945097;4157.792110394468;4223.070924396628;54975;55001.44998550043;55262.44737552573;55760.442395576334;56006;43269.35095973563;44442.77778611151;44640.10719785586;44654;44897.77551112289;40886.38670419946;42291.57708422938;43459;44635.10729785386;45016.3247551287;8209.384296177692;8279.420440569102;8424.368172387218;8504.744857654281;8545.145485451405;32151.67848321487;32955.67044329526;33020.83489582537;33122.5031624521;33191.33617327688;39631;41249.38125928053;42735.57264427316;42801.785991069846;43165.568344316154;10199.235057370875;10679.092277156218;10808.729781755519;11077.169212308949;11482.598109066143;11850.229735067192;12081;12112.394380281126;12561.246325220516;12728.745425091261;11285.363006383413;11555.537778489102;11587.942060289644;11609.825852612386;11941.984931280938;11441.084713222755;11655.825162622737;11838.993685536481;11951.043916486486;11968.359965020984;11139.498722557666;11489.310641361544;11623.418829058683;11644.941775291069;11926.701832454259;9477.336586438883;9675.612975480903;9755.463449510346;9927.056929591678;10018;8798.908324029277;9146.405483643543;9288.535573221177;9535.284853635867;9874.654387096418 08:11:04 INFO - PROCESS | 28978 | __end_tp_report 08:11:04 INFO - PROCESS | 28978 | __start_cc_report 08:11:04 INFO - PROCESS | 28978 | _x_x_mozilla_cycle_collect,920 08:11:04 INFO - PROCESS | 28978 | __end_cc_report 08:11:04 INFO - PROCESS | 28978 | __startTimestamp1453392664034__endTimestamp 08:11:04 INFO - PROCESS | 28978 | 08:11:04 INFO - PROCESS | 28978 | ------- Summary: start ------- 08:11:04 INFO - PROCESS | 28978 | Number of tests: 6 08:11:04 INFO - PROCESS | 28978 | 08:11:04 INFO - PROCESS | 28978 | [#0] dojo.html Cycles:165 Average:5167.56 Median:5427.86 stddev:667.00 (12.3%) stddev-sans-first:649.37 08:11:04 INFO - PROCESS | 28978 | Values: 3117.8 3155.4 3198.9 3200.5 3223.6 5146.9 5213.5 5248.6 5252.3 5288.1 5159.1 5210.8 5211.8 5213.3 5279.2 4738.6 4760.2 4793.8 4821.6 4909.5 498.8 4697.3 4766.9 4776.5 4843.6 4749.8 4771.6 4772.8 4780.4 4780.6 4687.6 4755.5 4761.8 4767.6 4775.7 4692.5 4732.0 4747.2 4747.3 4783.9 4965.5 4979.5 4980.0 4980.1 5010.1 5395.1 5473.8 5570.2 5588.7 5674.9 5599.7 5631.7 5651.4 5658.0 5660.0 5214.5 5281.3 5290.1 5295.0 5298.9 5579.2 5667.1 5691.0 5715.7 5792.3 5480.2 5480.4 5486.1 5488.4 5491.4 5452.4 5562.7 5566.6 5574.6 5583.5 5500.2 5547.2 5589.1 5603.6 5640.9 5586.4 5598.5 5604.7 5604.8 5607.1 4316.3 4387.2 4388.2 4395.0 4444.5 3876.8 3897.6 3905.8 3934.5 3964.9 5086.4 5104.0 5117.5 5141.8 5193.1 5517.1 5540.1 5541.3 5587.9 5595.2 5121.9 5163.0 5170.7 5187.3 5233.5 4780.2 4809.0 4810.9 4811.3 4846.3 5697.2 5709.7 5719.9 5765.0 5775.4 5601.6 5602.4 5603.7 5610.9 5630.2 5790.5 5815.9 5816.7 5818.5 5838.2 5427.9 5509.2 5546.3 5548.7 5631.8 5535.8 5541.6 5545.6 5548.1 5563.8 5370.9 5419.9 5436.8 5443.8 5497.2 5358.4 5439.1 5525.8 5600.2 5608.1 5457.7 5461.4 5469.7 5469.9 5493.6 5548.7 5560.4 5565.0 5567.7 5577.7 5264.2 5359.4 5386.1 5479.1 5497.5 08:11:04 INFO - PROCESS | 28978 | 08:11:04 INFO - PROCESS | 28978 | [#1] ext.html Cycles:180 Average:45869.13 Median:36696.91 stddev:79276.93 (216.0%) stddev-sans-first:79426.25 08:11:04 INFO - PROCESS | 28978 | Values: 533.0 540.5 556.2 565.7 581.2 28254.2 29114.6 36293.6 36341.0 36412.3 39284.6 39500.6 39575.4 39661.8 39749.0 8259.9 8425.7 8451.2 8452.7 8454.3 8273.1 8413.6 8424.4 8430.0 8430.7 8518.4 8595.5 8598.1 8610.0 8610.7 8324.3 8398.4 8401.0 8409.2 8444.2 8301.9 8454.7 8479.2 8488.6 8509.5 39151.4 39369.2 39604.4 39650.2 39672.8 3192.2 3212.1 3285.0 3285.5 3384.9 29557.7 29763.0 30109.4 30444.2 30855.0 3876.0 3928.5 3949.1 4001.8 4021.5 256797.0 257468.0 258134.0 258412.0 258444.0 51365.0 52802.7 56576.0 57106.1 58504.0 54393.5 54635.0 54730.0 54917.0 54925.9 14016.5 14125.0 14134.9 14142.5 14201.1 9940.7 10170.2 10174.5 10480.9 10721.6 18441.9 18768.5 18768.5 18817.2 18888.6 6985.4 7257.8 7348.9 7369.4 7462.0 933.4 943.5 966.5 1028.0 1100.7 28356.6 28480.4 28494.9 28855.3 28936.1 1000.8 1020.8 1026.7 1043.0 1137.4 12904.4 13259.7 13308.7 13382.1 13444.6 341467.0 344768.0 345356.0 345719.0 346481.0 52637.2 52896.7 52917.2 52971.0 52973.5 1214.1 1238.2 1244.1 1318.7 1352.2 22992.3 23394.8 23429.4 23552.9 23611.2 39269.6 39640.2 39685.8 39685.8 43122.0 228660.0 308316.0 313790.0 314634.0 314951.0 28496.4 29071.9 29105.4 29132.0 29147.0 39657.4 42827.1 43078.6 43467.0 43592.0 36638.3 36742.0 37538.0 37660.6 38311.8 37032.6 37368.8 37538.8 37583.0 37919.4 36361.1 36519.6 36636.8 36651.8 36964.3 29093.4 30231.8 30620.2 30620.4 30666.1 23699.8 24638.0 24873.3 25089.4 25094.6 08:11:04 INFO - PROCESS | 28978 | 08:11:04 INFO - PROCESS | 28978 | [#2] jquery.html Cycles:180 Average:27607.49 Median:5442.82 stddev:89978.03 (1653.2%) stddev-sans-first:90207.18 08:11:04 INFO - PROCESS | 28978 | Values: 363.2 363.9 365.3 366.9 369.0 13580.5 13586.7 15614.5 17119.6 18240.1 15257.5 15446.2 15856.4 15902.0 15913.6 5233.2 5456.2 5458.6 5462.6 5465.2 3994.6 4123.5 5338.6 5429.4 5852.2 5719.5 5970.8 6021.6 6030.5 6038.3 5933.8 5938.9 5954.0 5956.1 5960.3 5081.8 5103.3 5164.1 5172.2 5240.8 18334.3 19227.1 20004.9 20253.7 20279.5 2133.1 2175.9 2324.5 2399.8 2613.5 12533.3 12534.8 12538.9 12580.7 12891.7 1649.0 1730.2 1742.1 1782.3 1810.4 50237.7 51299.7 52129.7 52132.5 52494.7 9539.7 9681.8 9738.1 9801.3 9923.3 12762.7 12908.9 12916.6 12928.4 12929.4 7147.0 7201.2 7203.4 7214.5 7237.2 6788.2 6866.8 6869.7 6935.5 6938.4 5623.7 5679.5 5755.9 5790.3 5805.8 1651.8 1714.5 1756.4 1774.1 1800.7 924.2 927.9 928.2 930.4 1051.9 12969.0 14969.7 15197.6 15472.8 15960.9 887.9 919.4 921.5 947.9 983.4 9237.0 9251.8 9496.3 9671.5 9780.0 537917.0 550735.0 551879.0 556037.0 559574.0 70266.0 71110.6 71213.6 71452.6 71582.3 1109.5 1109.5 1115.1 1118.8 1128.3 14814.7 14986.5 15175.2 15288.0 15324.9 32777.7 32812.2 33056.0 33417.5 33605.7 42334.6 42700.0 42849.6 42983.8 44291.3 6939.0 6987.5 7173.8 7313.8 7413.4 7325.9 9195.7 9727.0 10778.8 11268.1 8570.3 9118.1 9238.3 9263.9 9296.2 9196.6 9603.5 9676.6 10162.2 10181.8 7205.4 8918.7 9126.1 9356.7 9698.4 7327.3 7521.1 7560.8 7570.3 7572.1 9445.5 9483.0 9508.0 9585.5 9680.4 08:11:04 INFO - PROCESS | 28978 | 08:11:04 INFO - PROCESS | 28978 | [#3] mootools.html Cycles:180 Average:5618.61 Median:6302.73 stddev:2916.44 (46.3%) stddev-sans-first:2906.49 08:11:04 INFO - PROCESS | 28978 | Values: 1293.4 1440.5 1456.2 1489.6 1570.5 7103.1 7710.0 7864.9 7879.2 7896.2 7701.3 7885.8 7886.5 7887.6 7898.1 1991.1 2031.3 2036.2 2306.1 2337.4 1934.1 2301.8 2356.9 2357.4 2360.4 2246.0 2272.6 2281.2 2281.2 2301.2 2276.4 2304.1 2308.9 2310.0 2313.5 2289.1 2290.7 2295.8 2298.4 2304.5 7952.9 8024.6 8026.8 8028.0 8036.0 4877.5 4937.4 4952.7 4962.1 4988.9 3052.9 3084.3 3154.9 3207.9 3211.8 1047.4 1056.2 1792.1 1812.7 1818.8 11064.9 11129.0 11134.8 11151.7 11162.1 4297.4 4313.8 4327.2 4362.2 4483.5 8961.6 9009.0 9038.5 9058.2 9060.1 4926.7 5011.0 5035.3 5041.5 5044.8 4593.0 4626.4 4637.5 4643.8 4644.8 3412.9 3450.8 3522.9 3628.3 3628.5 1101.6 1122.6 1127.9 1150.9 1156.8 1255.5 1286.3 1300.2 1324.6 1327.5 7311.7 7390.4 7768.5 7770.8 7773.0 1069.7 1082.8 1083.1 1084.7 1105.7 5882.9 5969.3 5975.0 5979.8 5980.5 9507.6 9642.4 9883.2 9938.5 9947.1 9701.2 9711.3 9718.9 9742.3 9848.7 7058.4 7227.5 7229.6 7240.3 7456.5 7475.9 7478.7 7604.4 7620.8 7629.2 8663.0 8694.4 8710.7 8717.2 8846.5 9089.6 9145.0 9283.3 9296.3 9318.4 7166.9 7211.5 7278.1 7296.6 7304.7 6895.7 6916.9 7594.1 7850.6 7964.5 7002.8 7035.0 7122.9 7280.6 7297.4 6885.1 7018.9 7245.4 7359.2 7378.0 7195.3 7251.4 7265.6 7268.9 7287.0 6230.1 6375.4 6382.0 6383.7 6388.5 6678.1 6735.3 6736.8 6739.8 6742.1 08:11:04 INFO - PROCESS | 28978 | 08:11:04 INFO - PROCESS | 28978 | [#4] prototype.html Cycles:180 Average:5228.42 Median:5886.91 stddev:1572.78 (26.7%) stddev-sans-first:1533.78 08:11:04 INFO - PROCESS | 28978 | Values: 338.8 344.3 348.1 348.2 353.2 5730.6 5813.2 5845.4 5959.2 5963.1 5678.9 5806.0 5809.0 5821.4 5828.0 4527.3 4534.5 4534.9 4536.8 4538.3 4350.9 4446.2 4459.6 4566.1 4569.3 4507.5 4507.8 4526.5 4539.0 4553.4 4513.2 4531.8 4545.8 4547.2 4556.6 4010.4 4029.5 4035.0 4037.3 4040.4 5423.3 5549.3 5559.4 5563.2 5573.9 5238.9 5246.1 5249.6 5250.0 5255.5 5931.1 6275.5 6275.9 6284.2 6285.2 4215.0 4242.0 4276.3 4282.6 4284.5 6375.8 6444.9 6447.5 6450.4 6482.1 4431.5 4437.1 4441.2 4443.0 4475.4 4359.0 4505.0 4505.3 4506.1 4508.3 5161.7 5181.9 5202.2 5204.3 5205.2 6259.7 6273.2 6277.2 6283.4 6294.0 1552.9 1599.7 1600.4 1601.0 1602.0 1017.6 1040.7 1068.6 1074.2 1084.3 5872.6 5878.5 5886.8 5887.0 5896.3 6371.8 6409.7 6426.3 6438.5 6439.5 5907.5 5910.9 5917.1 5919.5 5934.3 3380.3 3482.4 3488.4 3490.6 3497.8 6737.6 6744.9 6748.6 6749.2 6749.9 6615.2 6634.7 6634.8 6634.8 6636.5 6532.9 6717.0 6731.7 6732.8 6739.4 6218.4 6385.4 6459.9 6467.1 6473.3 6275.8 6382.3 6397.6 6415.8 6423.8 6704.9 6710.0 6711.4 6722.4 6729.0 4348.9 4426.9 4458.5 4459.4 4460.7 6405.9 6452.6 6457.2 6457.4 6464.3 6258.6 6315.1 6320.4 6322.0 6326.3 6193.2 6239.2 6290.9 6299.1 6308.3 6175.7 6187.1 6191.3 6191.5 6195.5 6321.4 6327.5 6330.9 6331.4 6338.7 6076.0 6167.4 6186.4 6190.2 6196.6 08:11:04 INFO - PROCESS | 28978 | 08:11:04 INFO - PROCESS | 28978 | [#5] yui.html Cycles:180 Average:13232.61 Median:24453.10 stddev:14755.26 (60.3%) stddev-sans-first:14766.71 08:11:04 INFO - PROCESS | 28978 | Values: 714.2 746.0 816.0 830.8 839.8 13425.3 13640.2 13652.5 13662.2 13673.8 12611.9 12651.6 12656.2 12664.7 12672.2 646.7 656.2 774.4 788.0 793.3 788.5 791.5 791.6 793.1 794.3 681.3 823.7 825.6 826.0 826.8 682.0 816.5 825.6 826.1 828.0 610.3 610.9 611.2 612.5 613.4 13021.2 13060.7 13088.4 13092.3 13109.4 12412.3 12775.9 12839.4 13000.4 13043.1 10314.2 10400.9 10406.0 10505.5 10602.5 3485.3 3578.5 3620.9 3723.8 3758.5 44154.0 44457.1 44518.0 45331.0 45941.1 9568.0 9600.2 9641.5 9703.7 9763.9 17664.8 17873.2 17900.2 17941.0 17968.0 7671.9 7733.0 7817.6 7869.8 8008.9 4238.8 4343.1 4372.5 4449.1 4454.7 3050.6 3078.5 3097.5 3102.7 3147.2 582.2 588.8 592.0 593.6 594.6 523.7 566.1 636.7 677.5 686.3 8550.3 8599.8 8682.9 8714.9 8752.6 534.8 629.0 653.4 661.4 679.8 3788.9 4019.2 4060.9 4157.8 4223.1 54975.0 55001.4 55262.4 55760.4 56006.0 43269.4 44442.8 44640.1 44654.0 44897.8 40886.4 42291.6 43459.0 44635.1 45016.3 8209.4 8279.4 8424.4 8504.7 8545.1 32151.7 32955.7 33020.8 33122.5 33191.3 39631.0 41249.4 42735.6 42801.8 43165.6 10199.2 10679.1 10808.7 11077.2 11482.6 11850.2 12081.0 12112.4 12561.2 12728.7 11285.4 11555.5 11587.9 11609.8 11942.0 11441.1 11655.8 11839.0 11951.0 11968.4 11139.5 11489.3 11623.4 11644.9 11926.7 9477.3 9675.6 9755.5 9927.1 10018.0 8798.9 9146.4 9288.5 9535.3 9874.7 08:11:04 INFO - PROCESS | 28978 | -------- Summary: end -------- 08:11:04 INFO - PROCESS | 28978 | 08:11:04 INFO - TEST-INFO | 28978: exit 0 08:11:04 INFO - TEST-OK | dromaeo_css | took 1112713ms 08:11:04 INFO - TEST-START | kraken 08:11:04 INFO - operating with platform_type : linux_ 08:11:04 INFO - Initialising browser for kraken test... 08:11:04 INFO - TEST-INFO | started process 29178 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsHbPMI/profile http://localhost:46818/getInfo.html) 08:11:08 INFO - PROCESS | 29178 | __metrics Screen width/height:1600/1200 08:11:08 INFO - PROCESS | 29178 | colorDepth:24 08:11:08 INFO - PROCESS | 29178 | Browser inner width/height: 1024/697 08:11:08 INFO - PROCESS | 29178 | __metrics 08:11:08 INFO - PROCESS | 29178 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:11:08 INFO - PROCESS | 29178 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:11:09 INFO - TEST-INFO | 29178: exit 0 08:11:09 INFO - Browser initialized. 08:11:09 INFO - Running cycle 1/1 for kraken test... 08:11:09 INFO - TEST-INFO | started process 29257 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsHbPMI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:21 INFO - PROCESS | 29257 | RSS: Main: 148926464 08:11:21 INFO - PROCESS | 29257 | 08:11:23 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46818/tests/kraken/driver.html?testName=audio-beat-detection) 08:11:24 INFO - PROCESS | 29257 | RSS: Main: 185712640 08:11:24 INFO - PROCESS | 29257 | 08:11:27 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46818/tests/kraken/driver.html?testName=audio-dft) 08:11:27 INFO - PROCESS | 29257 | RSS: Main: 176816128 08:11:27 INFO - PROCESS | 29257 | 08:11:30 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46818/tests/kraken/driver.html?testName=audio-fft) 08:11:31 INFO - PROCESS | 29257 | RSS: Main: 161837056 08:11:31 INFO - PROCESS | 29257 | 08:11:33 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46818/tests/kraken/driver.html?testName=audio-oscillator) 08:11:33 INFO - PROCESS | 29257 | RSS: Main: 163028992 08:11:33 INFO - PROCESS | 29257 | 08:11:35 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46818/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:11:36 INFO - PROCESS | 29257 | RSS: Main: 165486592 08:11:36 INFO - PROCESS | 29257 | 08:11:39 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46818/tests/kraken/driver.html?testName=imaging-darkroom) 08:11:39 INFO - PROCESS | 29257 | RSS: Main: 164667392 08:11:39 INFO - PROCESS | 29257 | 08:11:43 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46818/tests/kraken/driver.html?testName=imaging-desaturate) 08:11:43 INFO - PROCESS | 29257 | RSS: Main: 165756928 08:11:43 INFO - PROCESS | 29257 | 08:11:46 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46818/tests/kraken/driver.html?testName=json-parse-financial) 08:11:47 INFO - PROCESS | 29257 | RSS: Main: 165343232 08:11:47 INFO - PROCESS | 29257 | 08:11:48 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46818/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:11:49 INFO - PROCESS | 29257 | RSS: Main: 180011008 08:11:49 INFO - PROCESS | 29257 | 08:11:51 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46818/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:11:51 INFO - PROCESS | 29257 | RSS: Main: 177614848 08:11:51 INFO - PROCESS | 29257 | 08:11:53 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46818/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:11:54 INFO - PROCESS | 29257 | RSS: Main: 183148544 08:11:54 INFO - PROCESS | 29257 | 08:11:56 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46818/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:11:57 INFO - PROCESS | 29257 | RSS: Main: 189890560 08:11:57 INFO - PROCESS | 29257 | 08:11:59 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46818/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:00 INFO - PROCESS | 29257 | RSS: Main: 190234624 08:12:00 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | Cycle 1(1): loaded http://localhost:46818/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46818/tests/kraken/driver.html?testName=ai-astar) 08:12:02 INFO - PROCESS | 29257 | RSS: Main: 248197120 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | __start_tp_report 08:12:02 INFO - PROCESS | 29257 | _x_x_mozilla_page_load 08:12:02 INFO - PROCESS | 29257 | _x_x_mozilla_page_load_details 08:12:02 INFO - PROCESS | 29257 | |i|pagename|runs| 08:12:02 INFO - PROCESS | 29257 | |0;ai-astar;110;110;104;109;109;109;111;111;104;109 08:12:02 INFO - PROCESS | 29257 | |1;audio-beat-detection;159;127;154;165;129;152;152;129;161;134 08:12:02 INFO - PROCESS | 29257 | |2;audio-dft;162;161;162;161;161;161;160;159;163;163 08:12:02 INFO - PROCESS | 29257 | |3;audio-fft;75;74;93;100;73;74;73;118;97;73 08:12:02 INFO - PROCESS | 29257 | |4;audio-oscillator;103;96;144;95;95;97;137;96;96;143 08:12:02 INFO - PROCESS | 29257 | |5;imaging-gaussian-blur;109;110;110;109;109;109;109;109;110;109 08:12:02 INFO - PROCESS | 29257 | |6;imaging-darkroom;147;150;146;145;145;145;145;145;146;146 08:12:02 INFO - PROCESS | 29257 | |7;imaging-desaturate;96;96;96;96;98;98;98;97;97;97 08:12:02 INFO - PROCESS | 29257 | |8;json-parse-financial;55;55;55;55;56;56;57;58;61;54 08:12:02 INFO - PROCESS | 29257 | |9;json-stringify-tinderbox;66;67;66;67;68;69;69;68;68;68 08:12:02 INFO - PROCESS | 29257 | |10;stanford-crypto-aes;91;82;89;83;84;84;84;83;90;82 08:12:02 INFO - PROCESS | 29257 | |11;stanford-crypto-ccm;119;116;116;112;122;120;115;114;120;122 08:12:02 INFO - PROCESS | 29257 | |12;stanford-crypto-pbkdf2;151;139;158;155;149;138;148;150;147;148 08:12:02 INFO - PROCESS | 29257 | |13;stanford-crypto-sha256-iterative;69;67;71;69;68;67;66;68;66;67 08:12:02 INFO - PROCESS | 29257 | __end_tp_report 08:12:02 INFO - PROCESS | 29257 | __start_cc_report 08:12:02 INFO - PROCESS | 29257 | _x_x_mozilla_cycle_collect,963 08:12:02 INFO - PROCESS | 29257 | __end_cc_report 08:12:02 INFO - PROCESS | 29257 | __startTimestamp1453392722530__endTimestamp 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | ------- Summary: start ------- 08:12:02 INFO - PROCESS | 29257 | Number of tests: 14 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.50 stddev:2.55 (2.3%) stddev-sans-first:2.65 08:12:02 INFO - PROCESS | 29257 | Values: 110.0 110.0 104.0 109.0 109.0 109.0 111.0 111.0 104.0 109.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:153.00 stddev:14.81 (9.7%) stddev-sans-first:14.96 08:12:02 INFO - PROCESS | 29257 | Values: 159.0 127.0 154.0 165.0 129.0 152.0 152.0 129.0 161.0 134.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 08:12:02 INFO - PROCESS | 29257 | Values: 162.0 161.0 162.0 161.0 161.0 161.0 160.0 159.0 163.0 163.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#3] audio-fft Cycles:10 Average:85.00 Median:74.00 stddev:15.97 (21.6%) stddev-sans-first:16.53 08:12:02 INFO - PROCESS | 29257 | Values: 75.0 74.0 93.0 100.0 73.0 74.0 73.0 118.0 97.0 73.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:95.50 stddev:21.68 (22.7%) stddev-sans-first:22.84 08:12:02 INFO - PROCESS | 29257 | Values: 103.0 96.0 144.0 95.0 95.0 97.0 137.0 96.0 96.0 143.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:12:02 INFO - PROCESS | 29257 | Values: 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:1.56 (1.1%) stddev-sans-first:1.62 08:12:02 INFO - PROCESS | 29257 | Values: 147.0 150.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 08:12:02 INFO - PROCESS | 29257 | Values: 96.0 96.0 96.0 96.0 98.0 98.0 98.0 97.0 97.0 97.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.04 (3.6%) stddev-sans-first:2.12 08:12:02 INFO - PROCESS | 29257 | Values: 55.0 55.0 55.0 55.0 56.0 56.0 57.0 58.0 61.0 54.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:1.07 (1.6%) stddev-sans-first:0.97 08:12:02 INFO - PROCESS | 29257 | Values: 66.0 67.0 66.0 67.0 68.0 69.0 69.0 68.0 68.0 68.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.00 stddev:3.43 (4.1%) stddev-sans-first:2.92 08:12:02 INFO - PROCESS | 29257 | Values: 91.0 82.0 89.0 83.0 84.0 84.0 84.0 83.0 90.0 82.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:119.50 stddev:3.47 (2.9%) stddev-sans-first:3.64 08:12:02 INFO - PROCESS | 29257 | Values: 119.0 116.0 116.0 112.0 122.0 120.0 115.0 114.0 120.0 122.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:149.50 stddev:6.18 (4.1%) stddev-sans-first:6.48 08:12:02 INFO - PROCESS | 29257 | Values: 151.0 139.0 158.0 155.0 149.0 138.0 148.0 150.0 147.0 148.0 08:12:02 INFO - PROCESS | 29257 | 08:12:02 INFO - PROCESS | 29257 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.55 (2.3%) stddev-sans-first:1.58 08:12:02 INFO - PROCESS | 29257 | Values: 69.0 67.0 71.0 69.0 68.0 67.0 66.0 68.0 66.0 67.0 08:12:02 INFO - PROCESS | 29257 | -------- Summary: end -------- 08:12:02 INFO - PROCESS | 29257 | 08:12:03 INFO - TEST-INFO | 29257: exit 0 08:12:03 INFO - TEST-OK | kraken | took 58701ms 08:12:03 INFO - TEST-START | v8_7 08:12:03 INFO - operating with platform_type : linux_ 08:12:03 INFO - Initialising browser for v8_7 test... 08:12:03 INFO - TEST-INFO | started process 29504 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphULGcC/profile http://localhost:46818/getInfo.html) 08:12:07 INFO - PROCESS | 29504 | __metrics Screen width/height:1600/1200 08:12:07 INFO - PROCESS | 29504 | colorDepth:24 08:12:07 INFO - PROCESS | 29504 | Browser inner width/height: 1024/697 08:12:07 INFO - PROCESS | 29504 | __metrics 08:12:07 INFO - PROCESS | 29504 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:12:07 INFO - PROCESS | 29504 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:08 INFO - TEST-INFO | 29504: exit 0 08:12:08 INFO - Browser initialized. 08:12:08 INFO - Running cycle 1/1 for v8_7 test... 08:12:08 INFO - TEST-INFO | started process 29584 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphULGcC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:20 INFO - PROCESS | 29584 | RSS: Main: 149127168 08:12:20 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | Cycle 1(1): loaded http://localhost:46818/tests/v8_7/run.html (next: http://localhost:46818/tests/v8_7/run.html) 08:12:42 INFO - PROCESS | 29584 | RSS: Main: 592732160 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | __start_tp_report 08:12:42 INFO - PROCESS | 29584 | _x_x_mozilla_page_load 08:12:42 INFO - PROCESS | 29584 | _x_x_mozilla_page_load_details 08:12:42 INFO - PROCESS | 29584 | |i|pagename|runs| 08:12:42 INFO - PROCESS | 29584 | |0;Richards;167.47613465081227 08:12:42 INFO - PROCESS | 29584 | |1;DeltaBlue;190.22256039566292 08:12:42 INFO - PROCESS | 29584 | |2;Encrypt;279.72027972027973 08:12:42 INFO - PROCESS | 29584 | |3;Decrypt;5186.5284974093265 08:12:42 INFO - PROCESS | 29584 | |4;RayTrace;1132.5028312570782 08:12:42 INFO - PROCESS | 29584 | |5;Earley;796.1783439490446 08:12:42 INFO - PROCESS | 29584 | |6;Boyer;12432.098765432098 08:12:42 INFO - PROCESS | 29584 | |7;RegExp;42250 08:12:42 INFO - PROCESS | 29584 | |8;Splay;645.9948320413437 08:12:42 INFO - PROCESS | 29584 | |9;NavierStokes;4830.917874396136 08:12:42 INFO - PROCESS | 29584 | __end_tp_report 08:12:42 INFO - PROCESS | 29584 | __startTimestamp1453392762671__endTimestamp 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | ------- Summary: start ------- 08:12:42 INFO - PROCESS | 29584 | Number of tests: 10 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | [#0] Richards Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 08:12:42 INFO - PROCESS | 29584 | Values: 167.5 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | [#1] DeltaBlue Cycles:1 Average:190.22 Median:190.22 stddev:0.00 (0.0%) 08:12:42 INFO - PROCESS | 29584 | Values: 190.2 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 08:12:42 INFO - PROCESS | 29584 | Values: 279.7 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 08:12:42 INFO - PROCESS | 29584 | Values: 5186.5 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | [#4] RayTrace Cycles:1 Average:1132.50 Median:1132.50 stddev:0.00 (0.0%) 08:12:42 INFO - PROCESS | 29584 | Values: 1132.5 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 08:12:42 INFO - PROCESS | 29584 | Values: 796.2 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | [#6] Boyer Cycles:1 Average:12432.10 Median:12432.10 stddev:0.00 (0.0%) 08:12:42 INFO - PROCESS | 29584 | Values: 12432.1 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | [#7] RegExp Cycles:1 Average:42250.00 Median:42250.00 stddev:0.00 (0.0%) 08:12:42 INFO - PROCESS | 29584 | Values: 42250.0 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | [#8] Splay Cycles:1 Average:645.99 Median:645.99 stddev:0.00 (0.0%) 08:12:42 INFO - PROCESS | 29584 | Values: 646.0 08:12:42 INFO - PROCESS | 29584 | 08:12:42 INFO - PROCESS | 29584 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:12:42 INFO - PROCESS | 29584 | Values: 4830.9 08:12:42 INFO - PROCESS | 29584 | -------- Summary: end -------- 08:12:42 INFO - PROCESS | 29584 | 08:12:43 INFO - TEST-INFO | 29584: exit 0 08:12:43 INFO - TEST-OK | v8_7 | took 40128ms 08:12:43 INFO - SUITE-END | took 1211s 08:12:43 INFO - Completed test suite (00:20:11) 08:12:43 INFO - Working with test: dromaeo_css 08:12:43 INFO - Generating results file: dromaeo_css 08:12:43 INFO - Working with test: kraken 08:12:43 INFO - Generating results file: kraken 08:12:43 INFO - javascript benchmark 08:12:43 INFO - Working with test: v8_7 08:12:43 INFO - Generating results file: v8_7 08:12:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:12:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 08:12:43 INFO - process_Request line: dromaeo_css 6815.87 graph.html#tests=[[72,1,35]] 08:12:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:12:43 INFO - process_Request line: kraken 1506.20 graph.html#tests=[[232,1,35]] 08:12:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:12:43 INFO - process_Request line: v8_7 19800.72 graph.html#tests=[[230,1,35]] 08:12:43 INFO - RETURN: dromaeo_css: 6815.87 08:12:43 INFO - RETURN: kraken: 1506.20 08:12:43 INFO - RETURN: v8_7: 19800.72 08:12:43 INFO - javascript benchmark 08:12:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3117.7505799536034, 3155.447796635588, 3198.8880389186384, 3200.487921932491, 3223.564818749469, 5146.948530514703, 5213.504717051874, 5248.606354523412, 5252.264682944386, 5288.101022826119, 5159.071367153911, 5210.843674689756, 5211.817586384468, 5213.296205012322, 5279.1817268323475, 4738.573528382436, 4760.190767569504, 4793.832215872445, 4821.614270858323, 4909.459959404463, 498.75941221697593, 4697.295405689157, 4766.856994290177, 4776.546228108324, 4843.564079232869, 4749.833755818547, 4771.594414474774, 4772.76136193189, 4780.37855078841, 4780.569748722614, 4687.6249900007915, 4755.476897541268, 4761.785719642625, 4767.642426818003, 4775.71345719258, 4692.53074692528, 4731.976340118277, 4747.216709242971, 4747.264174053027, 4783.856484305476, 4965.453800081988, 4979.47715489872, 4980.0, 4980.078685443204, 5010.073136469765, 5395.0558652236095, 5473.781048758045, 5570.164475328693, 5588.692621905793, 5674.943250567483, 5599.6640201587625, 5631.71841407928, 5651.4348565143155, 5657.971710141464, 5659.971700141514, 5214.478552144755, 5281.339832520935, 5290.074237008508, 5295.0, 5298.947010529922, 5579.163125531203, 5667.064934285797, 5691.03252447085, 5715.714214289269, 5792.304923409218, 5480.205370221295, 5480.3971563128825, 5486.1222204447895, 5488.396276409591, 5491.36849262332, 5452.427495113036, 5562.666240025612, 5566.55467562594, 5574.581906356958, 5583.497485226349, 5500.1749737539685, 5547.195656629847, 5589.077802162597, 5603.579731520153, 5640.887182256414, 5586.35756887955, 5598.524125449301, 5604.747786349542, 5604.775808967595, 5607.130894711327, 4316.266234740102, 4387.210302145644, 4388.210122178039, 4395.0, 4444.488883778342, 3876.8449262029203, 3897.6492115709157, 3905.8047097645003, 3934.4688467057154, 3964.9207015860097, 5086.440491545927, 5103.974480127576, 5117.513836185631, 5141.794328226829, 5193.143131383355, 5517.062099443105, 5540.085885828793, 5541.33503979525, 5587.888242235133, 5595.160725891149, 5121.8719532012, 5163.044836705221, 5170.715610641376, 5187.299714538564, 5233.450487698737, 4780.1873681474235, 4809.0, 4810.855674329776, 4811.254255590389, 4846.29728689338, 5697.230873832063, 5709.714514274353, 5719.914201286901, 5765.04876695349, 5775.422457754191, 5601.60788744784, 5602.411746766531, 5603.747831347518, 5610.915836262541, 5630.183623374506, 5790.478856902899, 5815.883682326415, 5816.709164541671, 5818.534517238695, 5838.241028666416, 5427.864303392446, 5509.228707980806, 5546.306711661043, 5548.667079975215, 5631.802886898939, 5535.750891209825, 5541.612087153861, 5545.556355491632, 5548.112302031655, 5563.7774489019985, 5370.865728356823, 5419.945800541944, 5436.809711660073, 5443.836684899459, 5497.175423686319, 5358.437364076872, 5439.075357189208, 5525.751341189736, 5600.187972744011, 5608.130739735348, 5457.69982650958, 5461.426550212171, 5469.726513674221, 5469.890602188014, 5493.587980901369, 5548.667079975215, 5560.36055853582, 5565.026120428828, 5567.66594004361, 5577.693226872561, 5264.1577347625725, 5359.437259087739, 5386.13821788512, 5479.0959491683425, 5497.505224529652], "unit": "score", "name": "dojo.html", "value": 5127.8143444389625}, {"lowerIsBetter": false, "replicates": [532.9546988505977, 540.4622400711293, 556.2101815422105, 565.7256230728096, 581.1602234770755, 28254.15237542872, 29114.563281550767, 36293.63706362936, 36341.0, 36412.27175456489, 39284.607153928526, 39500.60499395005, 39575.40636890442, 39661.801690991575, 39748.99999999993, 8259.91740082599, 8425.662973481054, 8451.239388455038, 8452.661893524251, 8454.281386082159, 8273.131321211276, 8413.579321033954, 8424.368172387065, 8429.95785021077, 8430.747077587683, 8518.446300990416, 8595.484270943733, 8598.140185981414, 8610.0, 8610.741677749646, 8324.29243514302, 8398.412111152222, 8401.0, 8409.159084091603, 8444.197801208875, 8301.916980830174, 8454.661813527451, 8479.152084791533, 8488.575571221414, 8509.531975741333, 39151.41272880909, 39369.21261574752, 39604.40593391102, 39650.20699586021, 39672.80163599164, 3192.1859925719027, 3212.14878057315, 3284.96715032849, 3285.5071739239065, 3384.8984530464127, 29557.70442295571, 29763.0, 30109.397812043637, 30444.238894027603, 30855.0, 3876.0, 3928.5482169550583, 3949.0917089069676, 4001.779902105383, 4021.4973128358956, 256797.0, 257467.99999999814, 258134.0, 258412.0, 258444.0, 51365.0, 52802.73598632059, 56576.0, 57106.14340784892, 58504.0, 54393.45606543884, 54635.0, 54730.0, 54917.0, 54925.85963824677, 14016.509422170175, 14125.0, 14134.929325353307, 14142.50501232452, 14201.076929999517, 9940.652077177409, 10170.186385089175, 10174.4912754362, 10480.895191048145, 10721.571137154426, 18441.907790460962, 18768.53078673044, 18768.53078673044, 18817.15322810477, 18888.622227555374, 6985.406240469515, 7257.802462593719, 7348.926510734931, 7369.441197334377, 7461.962690186623, 933.3699752666922, 943.4527973775193, 966.5264020629841, 1027.9588816447408, 1100.691806294223, 28356.574651380244, 28480.430391392056, 28494.857525712654, 28855.278618034718, 28936.131916042552, 1000.8098461292477, 1020.806046851096, 1026.6765968719828, 1042.9895701043044, 1137.3630766770634, 12904.419301131284, 13259.66850828737, 13308.6672833178, 13382.063255572211, 13444.596662100153, 341467.0, 344768.0, 345356.0, 345719.0, 346481.0, 52637.2104418434, 52896.73551632217, 52917.2062419064, 52971.0, 52973.470265296855, 1214.1440284599337, 1238.1704258147063, 1244.147758785235, 1318.6769341260162, 1352.1819299323963, 22992.310230693107, 23394.76605233994, 23429.41426464352, 23552.882235588713, 23611.173608923604, 39269.6073039266, 39640.2071958565, 39685.801570991964, 39685.801570991964, 43122.0, 228660.0, 308316.0, 313790.0, 314634.0, 314951.0, 28496.43007139887, 29071.854640727506, 29105.41789164247, 29132.0, 29147.0, 39657.40513892352, 42827.143457130056, 43078.569214307456, 43467.0, 43592.0, 36638.267234655694, 36742.0, 37538.0, 37660.62339376681, 38311.80844095762, 37032.62967370292, 37368.81315593513, 37538.81230593829, 37583.0, 37919.43120853134, 36361.09097272589, 36519.63480365162, 36636.81681591575, 36651.816740916125, 36964.260714785014, 29093.41813163767, 30231.848840756535, 30620.234494137825, 30620.387592248477, 30666.080017599506, 23699.763002369757, 24638.0, 24873.253802385956, 25089.372765681004, 25094.62358064667], "unit": "score", "name": "ext.html", "value": 17735.796293119736}, {"lowerIsBetter": false, "replicates": [363.15385152594456, 363.892651667758, 365.31685747651886, 366.9064388580913, 368.9723270754694, 13580.456781728744, 13586.728265434685, 15614.453494127707, 17119.57201069974, 18240.087995600217, 15257.465988690397, 15446.150461724601, 15856.3657453702, 15902.045877247345, 15913.602159946007, 5233.18885572735, 5456.208849716789, 5458.61789674723, 5462.562994960394, 5465.207544905987, 3994.560598334181, 4123.525794533622, 5338.599605029638, 5429.429909859467, 5852.151438041481, 5719.542436605082, 5970.761169553212, 6021.578489505737, 6030.487408570277, 6038.275406951172, 5933.821985340425, 5938.851528711773, 5953.970230148865, 5956.106584012389, 5960.254968128984, 5081.79672813087, 5103.311053007834, 5164.096283150471, 5172.172452407634, 5240.842774716764, 18334.266629334812, 19227.13477893484, 20004.89997550003, 20253.696194557095, 20279.493012674655, 2133.125418578391, 2175.945601359979, 2324.4769926766344, 2399.7763935473517, 2613.4773045391, 12533.304062347142, 12534.81197782034, 12538.937305313415, 12580.748385032248, 12891.677708057374, 1649.0, 1730.1522254095528, 1742.0941110622532, 1782.27817733818, 1810.4387639831693, 50237.74881125571, 51299.74350128225, 52129.73935130338, 52132.47867521352, 52494.73752631251, 9539.713808585753, 9681.806363872684, 9738.123568878835, 9801.313908026512, 9923.305368624127, 12762.744745105047, 12908.935455322664, 12916.612501624966, 12928.353582320846, 12929.418176182095, 7146.964265178641, 7201.243869393743, 7203.351698347174, 7214.458915581353, 7237.167725711611, 6788.2193547742645, 6866.759663411756, 6869.656517174121, 6935.54918930278, 6938.444924406035, 5623.718814059281, 5679.545636349082, 5755.9424405756245, 5790.276215473066, 5805.767769289266, 1651.7604947282578, 1714.545645403969, 1756.394044054799, 1774.1484087637748, 1800.666876627802, 924.191332583989, 927.8561822917459, 928.1924725488868, 930.3719989007393, 1051.9000694933968, 12969.0, 14969.700605987819, 15197.568389057698, 15472.845271547365, 15960.920195399181, 887.933404994628, 919.4023884475012, 921.4931787516839, 947.9052094790466, 983.3755565215996, 9236.953815231016, 9251.814963700688, 9496.287778416647, 9671.468069256258, 9779.951100244596, 537917.0, 550735.0, 551879.0, 556037.0, 559574.0, 70266.0, 71110.64444677744, 71213.64393178104, 71452.64273678599, 71582.28417715861, 1109.4730003248553, 1109.517359948425, 1115.1134847796022, 1118.8196452742272, 1128.3173679923527, 14814.703705925605, 14986.47547335838, 15175.16536590498, 15288.0, 15324.923375383052, 32777.67222327746, 32812.1796955078, 33056.0, 33417.49873751944, 33605.663943360254, 42334.57665423306, 42700.0, 42849.571504284555, 42983.78508107439, 44291.33562996493, 6938.965305173442, 6987.475939304471, 7173.820654483679, 7313.780586582411, 7413.369863561442, 7325.926740732738, 9195.724128276162, 9727.0, 10778.784424311312, 11268.098552115647, 8570.314374850122, 9118.133777291147, 9238.260939124719, 9263.907360926574, 9296.209822164921, 9196.632134714537, 9603.471809050568, 9676.564554595201, 10162.23783216247, 10181.796364072528, 7205.423566114803, 8918.73243802687, 9126.133017363605, 9356.672516462164, 9698.36960597559, 7327.340539351484, 7521.0974683038385, 7560.773176804704, 7570.296683246446, 7572.091349038151, 9445.527723613654, 9482.95687474391, 9508.0, 9585.472798996123, 9680.370775899544], "unit": "score", "name": "jquery.html", "value": 8157.869543251773}, {"lowerIsBetter": false, "replicates": [1293.3727142335972, 1440.5174266620684, 1456.1845366594705, 1489.5978085916802, 1570.5366916759556, 7103.112110986127, 7709.961450192748, 7864.921350786491, 7879.212078792118, 7896.210378962101, 7701.268379503952, 7885.842283154333, 7886.526808391501, 7887.645055972481, 7898.052233731946, 1991.0741505200078, 2031.3195079648335, 2036.1549956767924, 2306.1006207579057, 2337.4039619896903, 1934.1199754111915, 2301.827362947777, 2356.8922606375063, 2357.363511851799, 2360.3745007573007, 2245.9775402246014, 2272.556851413975, 2281.190177486993, 2281.2129815213807, 2301.2290882554366, 2276.4422716434415, 2304.101400453816, 2308.8730119843403, 2309.9538009239723, 2313.5372925414986, 2289.0843662534953, 2290.725112986452, 2295.7933785959344, 2298.402415371999, 2304.4584522637165, 7952.880706789403, 8024.598770061532, 8026.759197224034, 8028.0, 8036.0, 4877.5366340197625, 4937.407511098655, 4952.653314268003, 4962.106820772259, 4988.90022199554, 3052.9389412211854, 3084.2906131589634, 3154.858031388593, 3207.8556464959133, 3211.7912335698106, 1047.350642601592, 1056.1550759392455, 1792.103948025987, 1812.7280907863794, 1818.7817461904524, 11064.889351106547, 11129.0, 11134.832977505344, 11151.665450036431, 11162.107031437465, 4297.355396690459, 4313.84901528445, 4327.156204540084, 4362.17118747437, 4483.50681425043, 8961.59672814725, 9009.0, 9038.502882341534, 9058.230050445654, 9060.093990601019, 4926.655134140576, 5010.974945125324, 5035.295058691786, 5041.546260836542, 5044.772985215674, 4593.035462552834, 4626.398568186114, 4637.46669133054, 4643.8374656886845, 4644.8374306899095, 3412.931741365159, 3450.810205438725, 3522.947155792665, 3628.310620982005, 3628.546431696038, 1101.5703875488566, 1122.6126986189752, 1127.932324060559, 1150.8849115088424, 1156.7744289863397, 1255.4727014653868, 1286.3246795432474, 1300.2133709105856, 1324.6224825924564, 1327.482281910056, 7311.67097480604, 7390.445716571171, 7768.53388796674, 7770.766876993699, 7773.0, 1069.7325668582855, 1082.8267477203767, 1083.0577397663926, 1084.7450849050467, 1105.6682995101437, 5882.941170588325, 5969.253843269591, 5975.043992961192, 5979.79070732531, 5980.461758441761, 9507.619695212252, 9642.42145471274, 9883.209343252522, 9938.453385063747, 9947.104760571583, 9701.175400091071, 9711.27165462579, 9718.854217186748, 9742.269329800152, 9848.704538863845, 7058.364747172779, 7227.530210536298, 7229.638518074075, 7240.312170343809, 7456.47804653669, 7475.925240747523, 7478.70085196586, 7604.42966777505, 7620.771376858703, 7629.2370762923265, 8663.0, 8694.434861733967, 8710.651573936972, 8717.171868672465, 8846.513441760764, 9089.59096840657, 9145.039770823967, 9283.257339412696, 9296.302777291865, 9318.394304370466, 7166.89249661266, 7211.531250468703, 7278.09023872016, 7296.562206267641, 7304.671289791866, 6895.689693963684, 6916.896246556205, 7594.050743657043, 7850.646720897459, 7964.522128672298, 7002.75490357835, 7035.0, 7122.928770712227, 7280.635968201463, 7297.379722723628, 6885.139357580302, 7018.894716579153, 7245.420366370783, 7359.190489046094, 7378.0, 7195.280471952763, 7251.41988640918, 7265.636718164176, 7268.89096663561, 7287.0, 6230.06549017651, 6375.394337537927, 6382.0, 6383.6808159592765, 6388.4569811566535, 6678.065070890177, 6735.326467353226, 6736.797896063126, 6739.764108256188, 6742.123523942052], "unit": "score", "name": "mootools.html", "value": 4627.346128578728}, {"lowerIsBetter": false, "replicates": [338.7865644643874, 344.27014728775004, 348.06197298281137, 348.23909757180576, 353.173573837221, 5730.6275092118985, 5813.2442782438275, 5845.357010728827, 5959.225300710907, 5963.135345374918, 5678.943210567893, 5806.0, 5809.04150815115, 5821.359650438449, 5827.970860145704, 4527.2530032544755, 4534.455865296169, 4534.9319760203625, 4536.7504787236685, 4538.296564032572, 4350.869473915787, 4446.177457170417, 4459.620932220765, 4566.086782643468, 4569.268916973285, 4507.459104907416, 4507.842225522108, 4526.4836279846295, 4538.954610453886, 4553.430821147356, 4513.232750432418, 4531.796069176911, 4545.818167273305, 4547.226971414867, 4556.589906908394, 4010.3783913493453, 4029.5366032906004, 4035.0, 4037.2732908076537, 4040.393940908858, 5423.267858839085, 5549.278593782823, 5559.360673522557, 5563.193336966117, 5573.888522229533, 5238.947610523922, 5246.108161612535, 5249.553787928031, 5250.002499525078, 5255.474452554752, 5931.110333450017, 6275.497960163176, 6275.937240627627, 6284.18305620271, 6285.214348206474, 4214.967333003403, 4242.00312926462, 4276.273033584298, 4282.550332215135, 4284.464441944757, 6375.808725738235, 6444.935550644481, 6447.484201263887, 6450.354964503512, 6482.092507049017, 4431.468223813099, 4437.06821567468, 4441.156180325728, 4443.044745379759, 4475.373447717322, 4359.0, 4504.977475112603, 4505.256632655575, 4506.053728717006, 4508.301213311942, 5161.741912904415, 5181.922271165936, 5202.24567437727, 5204.297419848272, 5205.24523944026, 6259.6870156492, 6273.247210334698, 6277.1525844010475, 6283.403076707706, 6293.96853015732, 1552.9301181446863, 1599.720048991422, 1600.407849095842, 1600.9919950400174, 1601.9839801601836, 1017.6133069433567, 1040.6721882606955, 1068.572570971602, 1074.248026381536, 1084.3060441317564, 5872.647641141545, 5878.5003274721275, 5886.793962211302, 5887.028640274307, 5896.262967129109, 6371.840703982345, 6409.711562979677, 6426.325235850262, 6438.517111216677, 6439.452646525097, 5907.4683278505145, 5910.940890591039, 5917.142014407887, 5919.526437884959, 5934.347221805598, 3380.273241253093, 3482.425399809054, 3488.4418493040994, 3490.6334834842482, 3497.7726447780815, 6737.629430381376, 6744.898826517606, 6748.561343512656, 6749.190097188369, 6749.898751518731, 6615.17310336208, 6634.677862748, 6634.767783127568, 6634.834129146713, 6636.535442518977, 6532.902006469907, 6717.0, 6731.663416829139, 6732.764353247613, 6739.393454589209, 6218.409251121137, 6385.425311721968, 6459.935400645933, 6467.126937863328, 6473.320301368289, 6275.8075965566395, 6382.329855365306, 6397.6481293529305, 6415.775447859489, 6423.807285781434, 6704.865902681821, 6710.0, 6711.362420570038, 6722.361375669304, 6729.0, 4348.891277718082, 4426.889327766831, 4458.487273963536, 4459.375687403831, 4460.710053846489, 6405.8718825624155, 6452.612843229421, 6457.160569125984, 6457.354264573505, 6464.288928217987, 6258.561900666909, 6315.115883776183, 6320.399562041599, 6322.0, 6326.3041065483685, 6193.194884664965, 6239.220097487814, 6290.874182516415, 6299.11812346281, 6308.27454842699, 6175.660338681416, 6187.102870083722, 6191.288001879841, 6191.473724733448, 6195.473384762346, 6321.367863213826, 6327.525435592257, 6330.936690633035, 6331.430171284606, 6338.651374174465, 6075.969620151871, 6167.414095660905, 6186.443220110212, 6190.1952746142715, 6196.597221180609], "unit": "score", "name": "prototype.html", "value": 4722.027999037338}, {"lowerIsBetter": false, "replicates": [714.1965289049818, 746.0264355016708, 815.9510429374238, 830.8047608811928, 839.7690635075354, 13425.32873356332, 13640.181589104648, 13652.522161724317, 13662.248576328298, 13673.794893076612, 12611.936940315309, 12651.620451386472, 12656.240625562472, 12664.746705065892, 12672.239665620069, 646.7122130651862, 656.2092678322633, 774.4230548241568, 787.9921200787991, 793.2781169136088, 788.5032429569392, 791.5448617045193, 791.6437603078609, 793.1434051224693, 794.2613369566301, 681.2540268406087, 823.7322870067222, 825.6202147012382, 826.0, 826.8428998490298, 682.0110839283035, 816.5141740664295, 825.5583262954351, 826.1078035721406, 828.035338830262, 610.346928786199, 610.9419605137549, 611.2023808929346, 612.5283531680626, 613.3835495327168, 13021.153625014344, 13060.673483162902, 13088.411021504055, 13092.345382730826, 13109.41007654658, 12412.317322547256, 12775.936120319431, 12839.358032098358, 13000.414981325863, 13043.088150260233, 10314.226433017553, 10400.895991040145, 10406.0, 10505.52725127371, 10602.46987650622, 3485.268093700326, 3578.4632305154173, 3620.9094772630633, 3723.7765734056043, 3758.5489741231227, 44154.0, 44457.11085778266, 44518.0, 45331.0, 45941.08117837658, 9567.952160239294, 9600.183984361267, 9641.517924103768, 9703.66037188695, 9763.902360976299, 17664.823351766318, 17873.19570619325, 17900.194491247927, 17941.0, 17968.0, 7671.923280767232, 7733.0, 7817.648205830751, 7869.763907082796, 8008.919910800817, 4238.809253583596, 4343.131373725268, 4372.519022907478, 4449.087936972913, 4454.665900057444, 3050.6491753448195, 3078.4766589679807, 3097.519884417919, 3102.736267417295, 3147.1660010097344, 582.2430839908103, 588.8145234251197, 592.0231617830614, 593.5993204586887, 594.6164723753242, 523.6700878446554, 566.145120867493, 636.700750647195, 677.4546490075438, 686.27255109584, 8550.250817340038, 8599.818067315133, 8682.86975695365, 8714.912850871537, 8752.606132724042, 534.8235082422791, 628.996855015722, 653.3792896748108, 661.3584822721951, 679.7994591595392, 3788.905277368088, 4019.2162528307285, 4060.8630082945097, 4157.792110394468, 4223.070924396628, 54975.0, 55001.44998550043, 55262.44737552573, 55760.442395576334, 56006.0, 43269.35095973563, 44442.77778611151, 44640.10719785586, 44654.0, 44897.77551112289, 40886.38670419946, 42291.57708422938, 43459.0, 44635.10729785386, 45016.3247551287, 8209.384296177692, 8279.420440569102, 8424.368172387218, 8504.744857654281, 8545.145485451405, 32151.67848321487, 32955.67044329526, 33020.83489582537, 33122.5031624521, 33191.33617327688, 39631.0, 41249.38125928053, 42735.57264427316, 42801.785991069846, 43165.568344316154, 10199.235057370875, 10679.092277156218, 10808.729781755519, 11077.169212308949, 11482.598109066143, 11850.229735067192, 12081.0, 12112.394380281126, 12561.246325220516, 12728.745425091261, 11285.363006383413, 11555.537778489102, 11587.942060289644, 11609.825852612386, 11941.984931280938, 11441.084713222755, 11655.825162622737, 11838.993685536481, 11951.043916486486, 11968.359965020984, 11139.498722557666, 11489.310641361544, 11623.418829058683, 11644.941775291069, 11926.701832454259, 9477.336586438883, 9675.612975480903, 9755.463449510346, 9927.056929591678, 10018.0, 8798.908324029277, 9146.405483643543, 9288.535573221177, 9535.284853635867, 9874.654387096418], "unit": "score", "name": "yui.html", "value": 6184.019383741592}], "name": "dromaeo_css", "value": 6815.868663980453}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 109.0, 109.0, 109.0, 111.0, 111.0, 104.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 154.0, 165.0, 129.0, 152.0, 152.0, 129.0, 161.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 159.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 93.0, 100.0, 73.0, 74.0, 73.0, 118.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.0}, {"lowerIsBetter": true, "replicates": [103.0, 96.0, 144.0, 95.0, 95.0, 97.0, 137.0, 96.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 150.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 98.0, 98.0, 98.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 56.0, 57.0, 58.0, 61.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [91.0, 82.0, 89.0, 83.0, 84.0, 84.0, 84.0, 83.0, 90.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 116.0, 112.0, 122.0, 120.0, 115.0, 114.0, 120.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.6}, {"lowerIsBetter": true, "replicates": [151.0, 139.0, 158.0, 155.0, 149.0, 138.0, 148.0, 150.0, 147.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 71.0, 69.0, 68.0, 67.0, 66.0, 68.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1506.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "Richards", "value": 210.7882419999999}, {"lowerIsBetter": false, "replicates": [190.22256039566292], "unit": "score", "name": "DeltaBlue", "value": 347.58232600000014}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1132.5028312570782], "unit": "score", "name": "RayTrace", "value": 653.410287}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [12432.098765432098], "unit": "score", "name": "Boyer", "value": 53.608245283018846}, {"lowerIsBetter": false, "replicates": [42250.0], "unit": "score", "name": "RegExp", "value": 21.561775147929005}, {"lowerIsBetter": false, "replicates": [645.9948320413437], "unit": "score", "name": "Splay", "value": 126.148068}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19800.724408872164}]} 08:12:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19800.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1506.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6815.87"}}} 08:12:43 INFO - Return code: 0 08:12:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:12:43 INFO - # TBPL SUCCESS # 08:12:43 INFO - Running post-action listener: _resource_record_post_action 08:12:43 INFO - Running post-run listener: _resource_record_post_run 08:12:45 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 539140096; Read time: 0; Write time: 422608 08:12:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237432832; Read time: 0; Write time: 229748 08:12:45 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 301707264; Read time: 0; Write time: 192860 08:12:45 INFO - Running post-run listener: _upload_blobber_files 08:12:45 INFO - Blob upload gear active. 08:12:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:12:45 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 08:12:45 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:12:45 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:12:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:12:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:12:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:12:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:46 INFO - (blobuploader) - INFO - Done attempting. 08:12:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:12:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:12:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:47 INFO - (blobuploader) - INFO - Done attempting. 08:12:47 INFO - (blobuploader) - INFO - Iteration through files over. 08:12:47 INFO - Return code: 0 08:12:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:12:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:12:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fdd9b08d8b1e58dace891977dac528140a3414491c5bf6243cda5b11733069492d62e10cd04ef05cfc097a9e9f383ca8c866de3fca178b73cb6f826c007d93b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db4ab3f6993f2549947364c67141b4280803ae6df6e570993852a3b9118e90727d90e52113757a1edaf49cb77be2ab482600d46f8f9460e0fdd8b75a59a2fd64"} 08:12:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:12:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:12:47 INFO - Contents: 08:12:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fdd9b08d8b1e58dace891977dac528140a3414491c5bf6243cda5b11733069492d62e10cd04ef05cfc097a9e9f383ca8c866de3fca178b73cb6f826c007d93b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db4ab3f6993f2549947364c67141b4280803ae6df6e570993852a3b9118e90727d90e52113757a1edaf49cb77be2ab482600d46f8f9460e0fdd8b75a59a2fd64"} 08:12:47 INFO - Running post-run listener: copy_logs_to_upload_dir 08:12:47 INFO - Copying logs to upload dir... 08:12:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:12:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.683356 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-21 08:12:46.786363) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 08:12:46.789768) ========= 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=0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fdd9b08d8b1e58dace891977dac528140a3414491c5bf6243cda5b11733069492d62e10cd04ef05cfc097a9e9f383ca8c866de3fca178b73cb6f826c007d93b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db4ab3f6993f2549947364c67141b4280803ae6df6e570993852a3b9118e90727d90e52113757a1edaf49cb77be2ab482600d46f8f9460e0fdd8b75a59a2fd64"} build_url:https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fdd9b08d8b1e58dace891977dac528140a3414491c5bf6243cda5b11733069492d62e10cd04ef05cfc097a9e9f383ca8c866de3fca178b73cb6f826c007d93b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db4ab3f6993f2549947364c67141b4280803ae6df6e570993852a3b9118e90727d90e52113757a1edaf49cb77be2ab482600d46f8f9460e0fdd8b75a59a2fd64"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 08:12:46.817857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:12:46.818421) ========= 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=0e2a256762fed810e2f0f810000001b3-1453391132.546361-1381961019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:12:46.901918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 08:12:46.902379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 08:12:46.902838) ========= ========= Total master_lag: 0.30 =========