builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1453409895.7 results: success (0) buildid: 20160121103146 builduid: 8b26ef7539664b90a6654cf84c1a0f06 revision: 66e07ef46853709e3fa91e7c9ad9fe6abf0d5f06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.695530) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.695982) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.696283) ========= 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=0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.719281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.719566) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.733687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.733994) ========= 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=0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.783541) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.783805) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.784167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.784444) ========= 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=0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 12:58:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-01-21 12:58:16 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172191 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.990645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:15.990928) ========= 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=0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014822 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:16.065589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 12:58:16.065912) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 66e07ef46853709e3fa91e7c9ad9fe6abf0d5f06 --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 66e07ef46853709e3fa91e7c9ad9fe6abf0d5f06 --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=0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 12:58:16,263 truncating revision to first 12 chars 2016-01-21 12:58:16,263 Setting DEBUG logging. 2016-01-21 12:58:16,264 attempt 1/10 2016-01-21 12:58:16,264 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/66e07ef46853?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 12:58:17,399 unpacking tar archive at: mozilla-central-66e07ef46853/testing/mozharness/ program finished with exit code 0 elapsedTime=1.431069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 12:58:17.510664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:17.510987) ========= echo 66e07ef46853709e3fa91e7c9ad9fe6abf0d5f06 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'66e07ef46853709e3fa91e7c9ad9fe6abf0d5f06'] 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=0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 66e07ef46853709e3fa91e7c9ad9fe6abf0d5f06 program finished with exit code 0 elapsedTime=0.004650 script_repo_revision: '66e07ef46853709e3fa91e7c9ad9fe6abf0d5f06' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:17.560144) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:17.560415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 12:58:17.570242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-21 12:58:17.570510) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:58:17 INFO - MultiFileLogger online at 20160121 12:58:17 in /builds/slave/test-pgo 12:58:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:58:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:58:17 INFO - {'append_to_log': False, 12:58:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:58:17 INFO - 'blob_upload_branch': 'Firefox', 12:58:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:58:17 INFO - 'branch': 'Firefox', 12:58:17 INFO - 'buildbot_json_path': 'buildprops.json', 12:58:17 INFO - 'config_files': ('talos/linux_config.py',), 12:58:17 INFO - 'default_actions': ('clobber', 12:58:17 INFO - 'read-buildbot-config', 12:58:17 INFO - 'download-and-extract', 12:58:17 INFO - 'populate-webroot', 12:58:17 INFO - 'create-virtualenv', 12:58:17 INFO - 'install', 12:58:17 INFO - 'run-tests'), 12:58:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:58:17 INFO - 'download_minidump_stackwalk': True, 12:58:17 INFO - 'download_symbols': 'ondemand', 12:58:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:58:17 INFO - 'tooltool.py': '/tools/tooltool.py', 12:58:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:58:17 INFO - '/tools/misc-python/virtualenv.py')}, 12:58:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:58:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:58:17 INFO - 'installer_path': 'installer.exe', 12:58:17 INFO - 'log_level': 'info', 12:58:17 INFO - 'log_name': 'talos', 12:58:17 INFO - 'log_to_console': True, 12:58:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:58:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:58:17 INFO - 'opt_config_files': (), 12:58:17 INFO - 'pip_index': False, 12:58:17 INFO - 'sps_profile': False, 12:58:17 INFO - 'sps_profile_interval': 0, 12:58:17 INFO - 'suite': 'dromaeojs-e10s', 12:58:17 INFO - 'system_bits': '32', 12:58:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:58:17 INFO - 'title': 'talos-linux64-ix-017', 12:58:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:58:17 INFO - 'use_talos_json': True, 12:58:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:58:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:58:17 INFO - 'work_dir': 'build'} 12:58:17 INFO - ##### 12:58:17 INFO - ##### Running clobber step. 12:58:17 INFO - ##### 12:58:17 INFO - Running pre-action listener: _resource_record_pre_action 12:58:17 INFO - Running main action method: clobber 12:58:17 INFO - rmtree: /builds/slave/test-pgo/build 12:58:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:58:18 INFO - Running post-action listener: _resource_record_post_action 12:58:18 INFO - ##### 12:58:18 INFO - ##### Running read-buildbot-config step. 12:58:18 INFO - ##### 12:58:18 INFO - Running pre-action listener: _resource_record_pre_action 12:58:18 INFO - Running main action method: read_buildbot_config 12:58:18 INFO - Using buildbot properties: 12:58:18 INFO - { 12:58:18 INFO - "project": "", 12:58:18 INFO - "product": "firefox", 12:58:18 INFO - "script_repo_revision": "production", 12:58:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:58:18 INFO - "repository": "", 12:58:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 12:58:18 INFO - "buildid": "20160121103146", 12:58:18 INFO - "pgo_build": "True", 12:58:18 INFO - "basedir": "/builds/slave/test-pgo", 12:58:18 INFO - "buildnumber": 80, 12:58:18 INFO - "slavename": "talos-linux64-ix-017", 12:58:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:58:18 INFO - "platform": "ubuntu64_hw", 12:58:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 12:58:18 INFO - "branch": "mozilla-central", 12:58:18 INFO - "repo_path": "mozilla-central", 12:58:18 INFO - "revision": "66e07ef46853709e3fa91e7c9ad9fe6abf0d5f06", 12:58:18 INFO - "stage_platform": "linux64-pgo", 12:58:18 INFO - "builduid": "8b26ef7539664b90a6654cf84c1a0f06", 12:58:18 INFO - "slavebuilddir": "test" 12:58:18 INFO - } 12:58:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:58:18 INFO - Running post-action listener: _resource_record_post_action 12:58:18 INFO - ##### 12:58:18 INFO - ##### Running download-and-extract step. 12:58:18 INFO - ##### 12:58:18 INFO - Running pre-action listener: _resource_record_pre_action 12:58:18 INFO - Running main action method: download_and_extract 12:58:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:18 INFO - https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:58:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/test_packages.json 12:58:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/test_packages.json 12:58:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:58:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:58:23 INFO - Downloaded 1448 bytes. 12:58:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:58:23 INFO - Using the following test package requirements: 12:58:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:58:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:58:23 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:58:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:23 INFO - u'jsshell-linux-x86_64.zip'], 12:58:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:58:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:58:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:58:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:58:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:58:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:58:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:58:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:58:23 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')]} 12:58:23 INFO - https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/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 12:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/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 12:58:36 INFO - Downloaded 22486570 bytes. 12:58:36 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'] 12:58:36 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 12:58:37 INFO - Return code: 0 12:58:37 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 12:58:37 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')]} 12:58:37 INFO - https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/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 12:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/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 12:58:39 INFO - Downloaded 22486570 bytes. 12:58:39 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'] 12:58:39 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 12:58:40 INFO - Return code: 0 12:58:40 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')]} 12:58:40 INFO - https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/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 12:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/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 12:58:41 INFO - Downloaded 10705515 bytes. 12:58:41 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'] 12:58:41 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 12:58:41 INFO - Return code: 0 12:58: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')]} 12:58:41 INFO - https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/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 12:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OZMZMdH7Tua1qt0056dYzw/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 12:58:43 INFO - Downloaded 55942227 bytes. 12:58:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:58:43 INFO - mkdir: /builds/slave/test-pgo/properties 12:58:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:58:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:58:43 INFO - Contents: 12:58:43 INFO - build_url:https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:58:43 INFO - Running post-action listener: _resource_record_post_action 12:58:43 INFO - Running post-action listener: set_extra_try_arguments 12:58:43 INFO - ##### 12:58:43 INFO - ##### Running populate-webroot step. 12:58:43 INFO - ##### 12:58:43 INFO - Running pre-action listener: _resource_record_pre_action 12:58:43 INFO - Running main action method: populate_webroot 12:58:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:58:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:58:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:58:43 INFO - '--tppagecycles', 12:58:43 INFO - '7'], 12:58:43 INFO - 'tests': ['tsvgm']}}, 12:58:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:58:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:58:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:58:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:58:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:58:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:58:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:43 INFO - 'talos_options': ['--e10s'], 12:58:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:43 INFO - 'tests': ['damp', 'tps']}, 12:58:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:43 INFO - 'talos_options': ['--e10s'], 12:58:43 INFO - 'tests': ['damp', 'tps']}, 12:58:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:58:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:58:43 INFO - 'other': {'tests': ['a11yr', 12:58:43 INFO - 'ts_paint', 12:58:43 INFO - 'tpaint', 12:58:43 INFO - 'sessionrestore', 12:58:43 INFO - 'sessionrestore_no_auto_restore']}, 12:58:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:58:43 INFO - 'tests': ['a11yr', 12:58:43 INFO - 'ts_paint', 12:58:43 INFO - 'tpaint', 12:58:43 INFO - 'sessionrestore', 12:58:43 INFO - 'sessionrestore_no_auto_restore']}, 12:58:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:58:43 INFO - 'tests': ['a11yr', 12:58:43 INFO - 'ts_paint', 12:58:43 INFO - 'tpaint', 12:58:43 INFO - 'sessionrestore', 12:58:43 INFO - 'sessionrestore_no_auto_restore']}, 12:58:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:58:43 INFO - 'tests': ['a11yr', 12:58:43 INFO - 'ts_paint', 12:58:43 INFO - 'tpaint', 12:58:43 INFO - 'sessionrestore', 12:58:43 INFO - 'sessionrestore_no_auto_restore']}, 12:58:43 INFO - 'other_l64': {'tests': ['a11yr', 12:58:43 INFO - 'ts_paint', 12:58:43 INFO - 'tpaint', 12:58:43 INFO - 'sessionrestore', 12:58:43 INFO - 'sessionrestore_no_auto_restore']}, 12:58:43 INFO - 'other_nol64': {'tests': ['a11yr', 12:58:43 INFO - 'ts_paint', 12:58:43 INFO - 'tpaint', 12:58:43 INFO - 'sessionrestore', 12:58:43 INFO - 'sessionrestore_no_auto_restore']}, 12:58:43 INFO - 'svgr': {'tests': ['tsvgx', 12:58:43 INFO - 'tsvgr_opacity', 12:58:43 INFO - 'tart', 12:58:43 INFO - 'tscrollx', 12:58:43 INFO - 'cart']}, 12:58:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:58:43 INFO - 'tests': ['tsvgx', 12:58:43 INFO - 'tsvgr_opacity', 12:58:43 INFO - 'tart', 12:58:43 INFO - 'tscrollx', 12:58:43 INFO - 'cart']}, 12:58:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:43 INFO - 'tests': ['tp5o']}, 12:58:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:43 INFO - 'talos_options': ['--e10s'], 12:58:43 INFO - 'tests': ['tp5o']}, 12:58:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:43 INFO - 'talos_options': ['--xperf_path', 12:58:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:43 INFO - 'tests': ['tp5n']}, 12:58:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:43 INFO - 'talos_options': ['--e10s', 12:58:43 INFO - '--xperf_path', 12:58:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:43 INFO - 'tests': ['tp5n']}}, 12:58:43 INFO - 'talos.zip': {'path': '', 12:58:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:58:43 INFO - Running post-action listener: _resource_record_post_action 12:58:43 INFO - ##### 12:58:43 INFO - ##### Running create-virtualenv step. 12:58:43 INFO - ##### 12:58:43 INFO - Running pre-action listener: _resource_record_pre_action 12:58:43 INFO - Running main action method: create_virtualenv 12:58:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:58:43 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 12:58:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:58:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:58:43 INFO - Using real prefix '/usr' 12:58:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:58:43 INFO - Installing distribute.............................................................................................................................................................................................done. 12:58:45 INFO - Installing pip.................done. 12:58:45 INFO - Return code: 0 12:58:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:58: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')]} 12:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58: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')]} 12:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:45 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 0x7fe8b4b12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1438660>, '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 0x1439560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439a10>, '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': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', '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 12:58:45 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 12:58:45 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 12:58:45 INFO - Using env: {'DISPLAY': ':0', 12:58:45 INFO - 'HOME': '/home/cltbld', 12:58:45 INFO - 'LANG': 'en_US.UTF-8', 12:58:45 INFO - 'LANGUAGE': 'en_US:en', 12:58:45 INFO - 'LOGNAME': 'cltbld', 12:58:45 INFO - 'MAIL': '/var/mail/cltbld', 12:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:45 INFO - 'MOZ_NO_REMOTE': '1', 12:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:45 INFO - 'NO_EM_RESTART': '1', 12:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:45 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:45 INFO - 'SHELL': '/bin/bash', 12:58:45 INFO - 'SHLVL': '1', 12:58:45 INFO - 'TERM': 'linux', 12:58:45 INFO - 'TMOUT': '86400', 12:58:45 INFO - 'USER': 'cltbld', 12:58:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', 12:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:45 INFO - '_': '/tools/buildbot/bin/python'} 12:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:45 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 12:58:45 INFO - Cleaning up... 12:58:45 INFO - Return code: 0 12:58:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:58: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')]} 12:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58: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')]} 12:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:45 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 0x7fe8b4b12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1438660>, '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 0x1439560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439a10>, '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': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', '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 12:58:45 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 12:58:45 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 12:58:45 INFO - Using env: {'DISPLAY': ':0', 12:58:45 INFO - 'HOME': '/home/cltbld', 12:58:45 INFO - 'LANG': 'en_US.UTF-8', 12:58:45 INFO - 'LANGUAGE': 'en_US:en', 12:58:45 INFO - 'LOGNAME': 'cltbld', 12:58:45 INFO - 'MAIL': '/var/mail/cltbld', 12:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:45 INFO - 'MOZ_NO_REMOTE': '1', 12:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:45 INFO - 'NO_EM_RESTART': '1', 12:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:45 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:45 INFO - 'SHELL': '/bin/bash', 12:58:45 INFO - 'SHLVL': '1', 12:58:45 INFO - 'TERM': 'linux', 12:58:45 INFO - 'TMOUT': '86400', 12:58:45 INFO - 'USER': 'cltbld', 12:58:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', 12:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:45 INFO - '_': '/tools/buildbot/bin/python'} 12:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:46 INFO - Downloading/unpacking psutil>=0.7.1 12:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:58:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:58:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:58:47 INFO - Installing collected packages: psutil 12:58:47 INFO - Running setup.py install for psutil 12:58:47 INFO - building 'psutil._psutil_linux' extension 12:58:47 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 12:58:48 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 12:58:48 INFO - building 'psutil._psutil_posix' extension 12:58:48 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 12:58:48 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 12:58:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:58:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:58:48 INFO - Successfully installed psutil 12:58:48 INFO - Cleaning up... 12:58:48 INFO - Return code: 0 12:58:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:58: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')]} 12:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58: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')]} 12:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:48 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 0x7fe8b4b12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1438660>, '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 0x1439560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439a10>, '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': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', '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 12:58:48 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 12:58:48 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 12:58:48 INFO - Using env: {'DISPLAY': ':0', 12:58:48 INFO - 'HOME': '/home/cltbld', 12:58:48 INFO - 'LANG': 'en_US.UTF-8', 12:58:48 INFO - 'LANGUAGE': 'en_US:en', 12:58:48 INFO - 'LOGNAME': 'cltbld', 12:58:48 INFO - 'MAIL': '/var/mail/cltbld', 12:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:48 INFO - 'MOZ_NO_REMOTE': '1', 12:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:48 INFO - 'NO_EM_RESTART': '1', 12:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:48 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:48 INFO - 'SHELL': '/bin/bash', 12:58:48 INFO - 'SHLVL': '1', 12:58:48 INFO - 'TERM': 'linux', 12:58:48 INFO - 'TMOUT': '86400', 12:58:48 INFO - 'USER': 'cltbld', 12:58:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', 12:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:48 INFO - '_': '/tools/buildbot/bin/python'} 12:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:58:48 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 12:58:48 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 12:58:48 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 12:58:48 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 12:58:48 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 12:58:48 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 12:58:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:58:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:58:50 INFO - Installing collected packages: mozsystemmonitor 12:58:50 INFO - Running setup.py install for mozsystemmonitor 12:58:50 INFO - Successfully installed mozsystemmonitor 12:58:50 INFO - Cleaning up... 12:58:50 INFO - Return code: 0 12:58:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:50 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 0x7fe8b4b12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1438660>, '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 0x1439560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439a10>, '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': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', '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 12:58:50 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 12:58:50 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 12:58:50 INFO - Using env: {'DISPLAY': ':0', 12:58:50 INFO - 'HOME': '/home/cltbld', 12:58:50 INFO - 'LANG': 'en_US.UTF-8', 12:58:50 INFO - 'LANGUAGE': 'en_US:en', 12:58:50 INFO - 'LOGNAME': 'cltbld', 12:58:50 INFO - 'MAIL': '/var/mail/cltbld', 12:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:50 INFO - 'MOZ_NO_REMOTE': '1', 12:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:50 INFO - 'NO_EM_RESTART': '1', 12:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:50 INFO - 'SHELL': '/bin/bash', 12:58:50 INFO - 'SHLVL': '1', 12:58:50 INFO - 'TERM': 'linux', 12:58:50 INFO - 'TMOUT': '86400', 12:58:50 INFO - 'USER': 'cltbld', 12:58:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', 12:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:50 INFO - '_': '/tools/buildbot/bin/python'} 12:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:50 INFO - Downloading/unpacking blobuploader==1.2.4 12:58:50 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 12:58:50 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 12:58:50 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 12:58:50 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 12:58:50 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 12:58:50 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 12:58:52 INFO - Downloading blobuploader-1.2.4.tar.gz 12:58:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:58:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:58:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:58: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 12:58: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 12:58: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 12:58: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 12:58: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 12:58: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 12:58:53 INFO - Downloading docopt-0.6.1.tar.gz 12:58:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:58:53 INFO - Installing collected packages: blobuploader, requests, docopt 12:58:53 INFO - Running setup.py install for blobuploader 12:58:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:58:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:58:53 INFO - Running setup.py install for requests 12:58:53 INFO - Running setup.py install for docopt 12:58:53 INFO - Successfully installed blobuploader requests docopt 12:58:53 INFO - Cleaning up... 12:58:53 INFO - Return code: 0 12:58:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:58: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')]} 12:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58: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')]} 12:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:54 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 0x7fe8b4b12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1438660>, '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 0x1439560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439a10>, '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': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', '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 12:58:54 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 12:58:54 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 12:58:54 INFO - Using env: {'DISPLAY': ':0', 12:58:54 INFO - 'HOME': '/home/cltbld', 12:58:54 INFO - 'LANG': 'en_US.UTF-8', 12:58:54 INFO - 'LANGUAGE': 'en_US:en', 12:58:54 INFO - 'LOGNAME': 'cltbld', 12:58:54 INFO - 'MAIL': '/var/mail/cltbld', 12:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:54 INFO - 'MOZ_NO_REMOTE': '1', 12:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:54 INFO - 'NO_EM_RESTART': '1', 12:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:54 INFO - 'SHELL': '/bin/bash', 12:58:54 INFO - 'SHLVL': '1', 12:58:54 INFO - 'TERM': 'linux', 12:58:54 INFO - 'TMOUT': '86400', 12:58:54 INFO - 'USER': 'cltbld', 12:58:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', 12:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:54 INFO - '_': '/tools/buildbot/bin/python'} 12:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:58:54 INFO - Running setup.py (path:/tmp/pip-L22CFD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:58:54 INFO - Running setup.py (path:/tmp/pip-lKyyJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:58:54 INFO - Running setup.py (path:/tmp/pip-tXV0T6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:58:54 INFO - Running setup.py (path:/tmp/pip-gVRlNa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:58:54 INFO - Running setup.py (path:/tmp/pip-2antDy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:58:54 INFO - Running setup.py (path:/tmp/pip-sb89qg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:58:54 INFO - Running setup.py (path:/tmp/pip-PZP7Kj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:58:54 INFO - Running setup.py (path:/tmp/pip-xFwphZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:58:54 INFO - Running setup.py (path:/tmp/pip-utyYlB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:58:54 INFO - Running setup.py (path:/tmp/pip-4TxnBw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:58:54 INFO - Running setup.py (path:/tmp/pip-6wAMND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:58:55 INFO - Running setup.py (path:/tmp/pip-hNeF7T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:58:55 INFO - Running setup.py (path:/tmp/pip-bftjUE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:58:55 INFO - Running setup.py (path:/tmp/pip-4CBA3u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:58:55 INFO - Running setup.py (path:/tmp/pip-cw1ayc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:58:55 INFO - Running setup.py (path:/tmp/pip-IJBJKF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:58:55 INFO - Running setup.py (path:/tmp/pip-NMBJ6B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:58:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:58:55 INFO - Running setup.py install for manifestparser 12:58:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:58:55 INFO - Running setup.py install for mozcrash 12:58:55 INFO - Running setup.py install for mozdebug 12:58:55 INFO - Running setup.py install for mozdevice 12:58:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:58:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:58:55 INFO - Running setup.py install for mozfile 12:58:55 INFO - Running setup.py install for mozhttpd 12:58:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Running setup.py install for mozinfo 12:58:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Running setup.py install for mozInstall 12:58:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Running setup.py install for mozleak 12:58:56 INFO - Running setup.py install for mozlog 12:58:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Running setup.py install for moznetwork 12:58:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Running setup.py install for mozprocess 12:58:56 INFO - Running setup.py install for mozprofile 12:58:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Running setup.py install for mozrunner 12:58:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:58:56 INFO - Running setup.py install for mozscreenshot 12:58:57 INFO - Running setup.py install for moztest 12:58:57 INFO - Running setup.py install for mozversion 12:58:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:58:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:58:57 INFO - Cleaning up... 12:58:57 INFO - Return code: 0 12:58:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:58:57 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')]} 12:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:57 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')]} 12:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:57 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 0x7fe8b4b12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1438660>, '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 0x1439560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439a10>, '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': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', '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 12:58:57 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 12:58:57 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 12:58:57 INFO - Using env: {'DISPLAY': ':0', 12:58:57 INFO - 'HOME': '/home/cltbld', 12:58:57 INFO - 'LANG': 'en_US.UTF-8', 12:58:57 INFO - 'LANGUAGE': 'en_US:en', 12:58:57 INFO - 'LOGNAME': 'cltbld', 12:58:57 INFO - 'MAIL': '/var/mail/cltbld', 12:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:57 INFO - 'MOZ_NO_REMOTE': '1', 12:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:57 INFO - 'NO_EM_RESTART': '1', 12:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:57 INFO - 'SHELL': '/bin/bash', 12:58:57 INFO - 'SHLVL': '1', 12:58:57 INFO - 'TERM': 'linux', 12:58:57 INFO - 'TMOUT': '86400', 12:58:57 INFO - 'USER': 'cltbld', 12:58:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', 12:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:57 INFO - '_': '/tools/buildbot/bin/python'} 12:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:58:57 INFO - Running setup.py (path:/tmp/pip-wwdNOT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:58:57 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)) 12:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:58:57 INFO - Running setup.py (path:/tmp/pip-tfhGey-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:58:57 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)) 12:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:58:57 INFO - Running setup.py (path:/tmp/pip-ewGMcn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:58:57 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)) 12:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:58:57 INFO - Running setup.py (path:/tmp/pip-rGjc4g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:58:57 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)) 12:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:58:57 INFO - Running setup.py (path:/tmp/pip-pGeSAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:58:57 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)) 12:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:58:57 INFO - Running setup.py (path:/tmp/pip-FNHGkf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:58:57 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)) 12:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:58:57 INFO - Running setup.py (path:/tmp/pip-NCFpql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:58:57 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)) 12:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:58:57 INFO - Running setup.py (path:/tmp/pip-rRmniK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:58:58 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)) 12:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:58:58 INFO - Running setup.py (path:/tmp/pip-AORTqP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:58:58 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)) 12:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:58:58 INFO - Running setup.py (path:/tmp/pip-4XGmrk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:58:58 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)) 12:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:58:58 INFO - Running setup.py (path:/tmp/pip-4XpQMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:58:58 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)) 12:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:58:58 INFO - Running setup.py (path:/tmp/pip-eujqnm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:58:58 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)) 12:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:58:58 INFO - Running setup.py (path:/tmp/pip-ZF0H1H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:58:58 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)) 12:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:58:58 INFO - Running setup.py (path:/tmp/pip-GrdPfq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:58:58 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)) 12:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:58:58 INFO - Running setup.py (path:/tmp/pip-DZqaMd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:58:58 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)) 12:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:58:58 INFO - Running setup.py (path:/tmp/pip-Jdn_FU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:58:58 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)) 12:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:58:58 INFO - Running setup.py (path:/tmp/pip-rljUon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:58:58 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)) 12:58:58 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)) 12:58:58 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)) 12:58:58 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)) 12:58:58 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)) 12:58:58 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)) 12:58:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:58: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 12:58: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 12:58: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 12:58: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 12:58: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 12:58: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 12:59:00 INFO - Downloading blessings-1.6.tar.gz 12:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:59:00 INFO - Installing collected packages: blessings 12:59:00 INFO - Running setup.py install for blessings 12:59:00 INFO - Successfully installed blessings 12:59:00 INFO - Cleaning up... 12:59:00 INFO - Return code: 0 12:59:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:59:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:59:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:59:00 INFO - Reading from file tmpfile_stdout 12:59:00 INFO - Current package versions: 12:59:00 INFO - argparse == 1.2.1 12:59:00 INFO - blessings == 1.6 12:59:00 INFO - blobuploader == 1.2.4 12:59:00 INFO - docopt == 0.6.1 12:59:00 INFO - manifestparser == 1.1 12:59:00 INFO - mozInstall == 1.12 12:59:00 INFO - mozcrash == 0.16 12:59:00 INFO - mozdebug == 0.1 12:59:00 INFO - mozdevice == 0.48 12:59:00 INFO - mozfile == 1.2 12:59:00 INFO - mozhttpd == 0.7 12:59:00 INFO - mozinfo == 0.9 12:59:00 INFO - mozleak == 0.1 12:59:00 INFO - mozlog == 3.1 12:59:00 INFO - moznetwork == 0.27 12:59:00 INFO - mozprocess == 0.22 12:59:00 INFO - mozprofile == 0.28 12:59:00 INFO - mozrunner == 6.11 12:59:00 INFO - mozscreenshot == 0.1 12:59:00 INFO - mozsystemmonitor == 0.0 12:59:00 INFO - moztest == 0.7 12:59:00 INFO - mozversion == 1.4 12:59:00 INFO - psutil == 3.1.1 12:59:00 INFO - requests == 1.2.3 12:59:00 INFO - wsgiref == 0.1.2 12:59:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:59:00 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')]} 12:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:00 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')]} 12:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:00 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 0x7fe8b4b12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1438660>, '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 0x1439560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439a10>, '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': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', '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 12:59:00 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 12:59:00 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 12:59:00 INFO - Using env: {'DISPLAY': ':0', 12:59:00 INFO - 'HOME': '/home/cltbld', 12:59:00 INFO - 'LANG': 'en_US.UTF-8', 12:59:00 INFO - 'LANGUAGE': 'en_US:en', 12:59:00 INFO - 'LOGNAME': 'cltbld', 12:59:00 INFO - 'MAIL': '/var/mail/cltbld', 12:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:00 INFO - 'MOZ_NO_REMOTE': '1', 12:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:00 INFO - 'NO_EM_RESTART': '1', 12:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:00 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:00 INFO - 'SHELL': '/bin/bash', 12:59:00 INFO - 'SHLVL': '1', 12:59:00 INFO - 'TERM': 'linux', 12:59:00 INFO - 'TMOUT': '86400', 12:59:00 INFO - 'USER': 'cltbld', 12:59:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', 12:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:00 INFO - '_': '/tools/buildbot/bin/python'} 12:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:01 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)) 12:59:01 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)) 12:59:01 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)) 12:59:01 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)) 12:59:01 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)) 12:59:01 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)) 12:59:01 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)) 12:59:01 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)) 12:59:01 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)) 12:59:01 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)) 12:59:01 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)) 12:59:01 INFO - Cleaning up... 12:59:01 INFO - Return code: 0 12:59:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:59: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')]} 12:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59: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')]} 12:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8b4b12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1438660>, '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 0x1439560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439a10>, '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': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', '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 12:59:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 12:59:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:59:01 INFO - Using env: {'DISPLAY': ':0', 12:59:01 INFO - 'HOME': '/home/cltbld', 12:59:01 INFO - 'LANG': 'en_US.UTF-8', 12:59:01 INFO - 'LANGUAGE': 'en_US:en', 12:59:01 INFO - 'LOGNAME': 'cltbld', 12:59:01 INFO - 'MAIL': '/var/mail/cltbld', 12:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:01 INFO - 'MOZ_NO_REMOTE': '1', 12:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:01 INFO - 'NO_EM_RESTART': '1', 12:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:01 INFO - 'SHELL': '/bin/bash', 12:59:01 INFO - 'SHLVL': '1', 12:59:01 INFO - 'TERM': 'linux', 12:59:01 INFO - 'TMOUT': '86400', 12:59:01 INFO - 'USER': 'cltbld', 12:59:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', 12:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:01 INFO - '_': '/tools/buildbot/bin/python'} 12:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:01 INFO - Downloading/unpacking jsonschema 12:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:59:03 INFO - Downloading/unpacking functools32 (from jsonschema) 12:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:03 INFO - Downloading functools32-3.2.3-2.tar.gz 12:59:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:59:03 INFO - warning: no files found matching '*.txt' 12:59:03 INFO - no previously-included directories found matching 'build' 12:59:03 INFO - no previously-included directories found matching 'dist' 12:59:03 INFO - no previously-included directories found matching '.git*' 12:59:03 INFO - Installing collected packages: jsonschema, functools32 12:59:03 INFO - Running setup.py install for functools32 12:59:03 INFO - warning: no files found matching '*.txt' 12:59:03 INFO - no previously-included directories found matching 'build' 12:59:03 INFO - no previously-included directories found matching 'dist' 12:59:03 INFO - no previously-included directories found matching '.git*' 12:59:03 INFO - Successfully installed jsonschema functools32 12:59:03 INFO - Cleaning up... 12:59:03 INFO - Return code: 0 12:59:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:59:03 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')]} 12:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:03 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')]} 12:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:03 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 0x7fe8b4b12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1438660>, '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 0x1439560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439a10>, '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': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', '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 12:59:03 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 12:59:03 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 12:59:03 INFO - Using env: {'DISPLAY': ':0', 12:59:03 INFO - 'HOME': '/home/cltbld', 12:59:03 INFO - 'LANG': 'en_US.UTF-8', 12:59:03 INFO - 'LANGUAGE': 'en_US:en', 12:59:03 INFO - 'LOGNAME': 'cltbld', 12:59:03 INFO - 'MAIL': '/var/mail/cltbld', 12:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:03 INFO - 'MOZ_NO_REMOTE': '1', 12:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:03 INFO - 'NO_EM_RESTART': '1', 12:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:03 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:03 INFO - 'SHELL': '/bin/bash', 12:59:03 INFO - 'SHLVL': '1', 12:59:03 INFO - 'TERM': 'linux', 12:59:03 INFO - 'TMOUT': '86400', 12:59:03 INFO - 'USER': 'cltbld', 12:59:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', 12:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:03 INFO - '_': '/tools/buildbot/bin/python'} 12:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:03 INFO - Downloading/unpacking flake8 12:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:59:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:59:05 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 12:59:05 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 12:59:05 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 12:59:05 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 12:59:05 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 12:59:05 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 12:59:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:59:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:59:05 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 12:59:05 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 12:59:05 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 12:59:05 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 12:59:05 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 12:59:05 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 12:59:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:59: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 12:59: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 12:59: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 12:59: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 12:59: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 12:59: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 12:59:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:59:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:59:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:59:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:59:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:59:06 INFO - no previously-included directories found matching 'docs/_build' 12:59:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:59:06 INFO - Running setup.py install for pep8 12:59:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:59:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:59:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:59:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:59:06 INFO - no previously-included directories found matching 'docs/_build' 12:59:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:59:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:59:06 INFO - Cleaning up... 12:59:06 INFO - Return code: 0 12:59:06 INFO - Running post-action listener: _resource_record_post_action 12:59:06 INFO - Running post-action listener: _start_resource_monitoring 12:59:06 INFO - Starting resource monitoring. 12:59:06 INFO - ##### 12:59:06 INFO - ##### Running install step. 12:59:06 INFO - ##### 12:59:06 INFO - Running pre-action listener: _resource_record_pre_action 12:59:06 INFO - Running main action method: install 12:59:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:59:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:59:06 INFO - Reading from file tmpfile_stdout 12:59:06 INFO - Detecting whether we're running mozinstall >=1.0... 12:59:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:59:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:59:06 INFO - Reading from file tmpfile_stdout 12:59:06 INFO - Output received: 12:59:06 INFO - Usage: mozinstall [options] installer 12:59:06 INFO - Options: 12:59:06 INFO - -h, --help show this help message and exit 12:59:06 INFO - -d DEST, --destination=DEST 12:59:06 INFO - Directory to install application into. [default: 12:59:06 INFO - "/builds/slave/test-pgo"] 12:59:06 INFO - --app=APP Application being installed. [default: firefox] 12:59:06 INFO - mkdir: /builds/slave/test-pgo/build/application 12:59:06 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'] 12:59:06 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 12:59:22 INFO - Reading from file tmpfile_stdout 12:59:22 INFO - Output received: 12:59:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:59:22 INFO - Running post-action listener: _resource_record_post_action 12:59:22 INFO - ##### 12:59:22 INFO - ##### Running run-tests step. 12:59:22 INFO - ##### 12:59:22 INFO - Running pre-action listener: _resource_record_pre_action 12:59:22 INFO - Running main action method: run_tests 12:59:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:59:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:59:22 INFO - Python 2.7.3 12:59:22 INFO - Return code: 0 12:59:22 INFO - grabbing minidump binary from tooltool 12:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:22 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 0x1438660>, '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 0x1439560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:59:22 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 12:59:22 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 12:59:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:59:23 INFO - Return code: 0 12:59:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:59:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:59:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:59:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:59:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:59:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:59:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:59:24 INFO - Return code: 0 12:59:24 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 12:59:24 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:59:24 INFO - Using env: {'DISPLAY': ':0', 12:59:24 INFO - 'HOME': '/home/cltbld', 12:59:24 INFO - 'LANG': 'en_US.UTF-8', 12:59:24 INFO - 'LANGUAGE': 'en_US:en', 12:59:24 INFO - 'LOGNAME': 'cltbld', 12:59:24 INFO - 'MAIL': '/var/mail/cltbld', 12:59:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:59:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:24 INFO - 'MOZ_NO_REMOTE': '1', 12:59:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:24 INFO - 'NO_EM_RESTART': '1', 12:59:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:59:24 INFO - 'PWD': '/builds/slave/test-pgo', 12:59:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:59:24 INFO - 'SHELL': '/bin/bash', 12:59:24 INFO - 'SHLVL': '1', 12:59:24 INFO - 'TERM': 'linux', 12:59:24 INFO - 'TMOUT': '86400', 12:59:24 INFO - 'USER': 'cltbld', 12:59:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070', 12:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:24 INFO - '_': '/tools/buildbot/bin/python'} 12:59:24 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:59:24 INFO - mozversion application_buildid: 20160121103146 12:59:24 INFO - mozversion application_changeset: 66e07ef46853709e3fa91e7c9ad9fe6abf0d5f06 12:59:24 INFO - mozversion application_display_name: Nightly 12:59:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:59:24 INFO - mozversion application_name: Firefox 12:59:24 INFO - mozversion application_remotingname: firefox 12:59:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:59:24 INFO - mozversion application_vendor: Mozilla 12:59:24 INFO - mozversion application_version: 46.0a1 12:59:24 INFO - mozversion platform_buildid: 20160121103146 12:59:24 INFO - mozversion platform_changeset: 66e07ef46853709e3fa91e7c9ad9fe6abf0d5f06 12:59:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:59:24 INFO - mozversion platform_version: 46.0a1 12:59:24 INFO - using testdate: 1453409964 12:59:24 INFO - actual date: 1453409964 12:59:24 INFO - starting webserver on 'localhost:32849' 12:59:24 INFO - SUITE-START | Running 3 tests 12:59:24 INFO - TEST-START | dromaeo_css 12:59:24 INFO - operating with platform_type : linux_ 12:59:24 INFO - Initialising browser for dromaeo_css test... 12:59:24 INFO - TEST-INFO | started process 29847 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsEx6fV/profile http://localhost:32849/getInfo.html) 12:59:27 INFO - PROCESS | 29847 | 12:59:27 INFO - PROCESS | 29847 | (process:29929): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:59:28 INFO - PROCESS | 29847 | __metrics Screen width/height:1600/1200 12:59:28 INFO - PROCESS | 29847 | colorDepth:24 12:59:28 INFO - PROCESS | 29847 | Browser inner width/height: 1024/697 12:59:28 INFO - PROCESS | 29847 | __metrics 12:59:28 INFO - PROCESS | 29847 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:59:29 INFO - TEST-INFO | 29847: exit 0 12:59:29 INFO - Browser initialized. 12:59:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:59:29 INFO - TEST-INFO | started process 29978 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsEx6fV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:30 INFO - PROCESS | 29978 | 12:59:30 INFO - PROCESS | 29978 | (process:30038): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:59:41 INFO - PROCESS | 29978 | RSS: Main: 150290432 12:59:41 INFO - PROCESS | 29978 | 13:00:30 INFO - PROCESS | 29978 | 1453410030826 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] 13:02:39 INFO - PROCESS | 29978 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32849/tests/dromaeo/cssquery-ext.html) 13:02:40 INFO - PROCESS | 29978 | RSS: Main: 157011968 13:02:40 INFO - PROCESS | 29978 | 13:05:42 INFO - PROCESS | 29978 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-ext.html (next: http://localhost:32849/tests/dromaeo/cssquery-jquery.html) 13:05:43 INFO - PROCESS | 29978 | RSS: Main: 151969792 13:05:43 INFO - PROCESS | 29978 | 13:08:45 INFO - PROCESS | 29978 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32849/tests/dromaeo/cssquery-mootools.html) 13:08:45 INFO - PROCESS | 29978 | RSS: Main: 151150592 13:08:45 INFO - PROCESS | 29978 | 13:11:47 INFO - PROCESS | 29978 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32849/tests/dromaeo/cssquery-prototype.html) 13:11:47 INFO - PROCESS | 29978 | RSS: Main: 151121920 13:11:47 INFO - PROCESS | 29978 | 13:14:50 INFO - PROCESS | 29978 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32849/tests/dromaeo/cssquery-yui.html) 13:14:50 INFO - PROCESS | 29978 | RSS: Main: 152014848 13:14:50 INFO - PROCESS | 29978 | 13:17:53 INFO - PROCESS | 29978 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-yui.html (next: http://localhost:32849/tests/dromaeo/cssquery-dojo.html) 13:17:53 INFO - PROCESS | 29978 | RSS: Main: 153563136 13:17:53 INFO - PROCESS | 29978 | 13:17:53 INFO - PROCESS | 29978 | __start_tp_report 13:17:53 INFO - PROCESS | 29978 | _x_x_mozilla_page_load 13:17:53 INFO - PROCESS | 29978 | _x_x_mozilla_page_load_details 13:17:53 INFO - PROCESS | 29978 | |i|pagename|runs| 13:17:53 INFO - PROCESS | 29978 | |0;dojo.html;3158.3209609933874;3174.793638413503;3194.8722051117957;3207.759418043647;3211.6788321167887;5039.974800126003;5088.872778180547;5115.488451154883;5126.743662816858;5132.974335128324;5047.84856454306;5112.769925353358;5121.129408000639;5125.28246045553;5171.974140129303;4707.035057813148;4716.481187069419;4742.810287588492;4803.591694705954;4813.831515896944;4774.2122549779415;4777.928331075037;4817.51824817519;4829.637777166709;4856.17445034345;4629.310301739857;4669.299605059235;4710.74090924999;4738.218193997986;4764.666473346867;4696;4721.929171062437;4722.693024953367;4734.147853386424;4755.334253204554;4654.2785868190485;4701.412323459567;4708.387909571768;4719.504452032522;4746.02706445178;4911.533404326583;4974.129527332702;4986.82546110888;5069.543741063285;5115.18157094863;5548.445155484419;5555.861103472405;5556.72216389183;5579.69311687857;5588.972055139699;5454.945450545483;5604.635698679573;5608.775648974036;5617.466340697627;5671.461211184972;5177.559907407875;5243.580513558906;5244.29202057725;5245.9737701312015;5253.001929633358;5683.488486036276;5685.886282274331;5686.715664216773;5689.459501347365;5694.914576281359;5346.8663283417445;5389.083855744454;5431.049566325956;5437.809676661298;5502.449755024546;5519.779208831682;5547.084731019418;5554.444555544494;5558.944410555923;5622.775088996476;5430.321209848769;5436.266104075979;5458.5087342139395;5460.590455715837;5474.343078830486;5390.326209223847;5473.261109750133;5485.122380419114;5487.506124448819;5545.584081193927;4335.609795118455;4339.609435150852;4347.217500849814;4369.213541562485;4382.824687012548;3889.922201555953;3902;3905.9218815624095;3918.686505079587;3930.9017274568364;5142.794288228504;5160.612954028463;5197.428282888879;5206.687598744087;5264.736763161826;5579.776808927679;5594.328680558359;5600;5600.943990560042;5615.157726341;5266.183741519994;5272.340957380327;5281.339832520935;5282.788688452419;5311.309529761106;4668.276417155346;4702.858914232578;4716.882077948078;4737.786799594027;4758.833440829554;5724.398938111522;5754.625949313281;5770.798022069207;5780.826575202751;5786.450287222707;5554.305711786027;5557.72211389437;5560.666360018412;5563.610547261653;5582.776688932559;5594.384617692132;5617.382087970402;5730.455606717355;5737.9139312911175;5853.502452291433;5448.4006759257245;5455.318085239345;5455.563554915677;5460.262864513399;5460.781568737365;5517.44825517445;5518.117101263779;5520.06158952987;5521.116621340727;5572.414896435978;5312.495312945264;5334.253204551288;5393.9730301348245;5425.891482170414;5470.097433923358;5360.41035486104;5430.049741295336;5442;5444.265024221838;5463.508284254277;5259.39516955555;5331.546818520469;5336.7598458068705;5342.332208473941;5386.703731294817;5301.443348448357;5361.946380536145;5386.084365657769;5409.756560954688;5416.106342453451;5300.946990530046;5301.5493683037375;5306.52241298285;5309.840704778863;5324.547413469743 13:17:53 INFO - PROCESS | 29978 | |1;ext.html;537.7150110441465;562.580877246451;588.8174665853586;593.5014587746292;602.0848310567936;33942.49086263708;34445.89986901178;34519.827400863025;34601;34655.480167797505;37258.8137059315;37540.62459375405;37600.623993760055;37620.24759504808;37686.0578485538;8337.207965243293;8445.619947102365;8511.489310641351;8534.57327133644;8561.400701950866;8319.417640765148;8390.454620449682;8416.83166336673;8427.157284271554;8456.957715211416;8467.153284671545;8569.442986205877;8616.224539791418;8628.396012279143;8637.697680581181;8426.07313195548;8445;8499.532525711084;8499.915000849975;8534.957325213396;8423.284020858235;8513.361497887683;8513.404061715682;8546.61540230691;8579.656813727443;37174.32715527808;37544.43683344752;37719.62280377188;37748.62251377506;38021.0494737631;2549.069589599783;2601.2456387647558;2660.840349579012;2666.413389054405;3009.8344591047485;25755.871220643963;25978.870105649352;26012.34969125768;26409.73590264111;26631.467370652674;3774;3921.3529767588316;3940.290747665419;3980.8805735827973;4026.4362989181536;219434;220926;221610;221652;221687;50984.49015509872;54378.45621543813;54525;54811;54848.177277340874;44947;60508.394916051155;61113.38886611166;61530.692346538875;61634;13392.933035334761;13434.462621495226;13558.186508809504;13572.1856688599;13595.456181752817;10298.897011029794;10310.43292618913;10311.84532232017;10354.11989980845;10372.792544149075;18292.17685204169;18423.170957306953;18494.81505184931;18509.444716658523;18530.722039169425;7235.312645298688;7986.562418764562;8158.755237342771;8204.138565450661;8214.548199848947;903.4624398482893;920.5949382271779;930.2511478260066;952.3714348529937;1020.3979652005353;27110.457790844466;27729.168124956283;27982.86008569985;28040.71959280422;28053.859730701217;1009.1926458832904;1009.3590569988111;1016.8373060310463;1019.4749703902496;1022.4529876516177;14576.854231457763;14595.78106328406;15022.699546009018;15629.687406252038;15654.765178522332;403331;408803;410950;411637;411867;51134.74432627887;51465;51924.48075519272;52019.47980520147;52107.73946130321;1236.2706003457822;1244.9066320026034;1287.9678008049686;1298.363801737142;1302.0755263762835;27432.45135097247;28269.71730282671;28700.282492937844;28727.425451490435;28952;42478;42953.57046429496;43229;43263.78368108139;43423.565764341954;305335;306795;306798;307002;309144;28575;36577.81711091428;37725.62274377331;39937.600623993385;41454;37161.256774864894;37355.81322093372;37425.4386184202;37748.245035099695;38438.807805960794;31985.18305757819;32511;32819.17952051218;33244.33511329808;33540.66459335473;34748.65251347555;34790.65209347874;35150;35297.647023530466;35333.29333413369;33318.666813331554;34018.489722653685;34518.82740586281;34542.13644658803;34659.30681386409;29097.563536547394;31715.20711982219;32004.67995320017;32139.196520087185;32166.67833321637;24327.391815204763;24562.385940351633;24615.38461538476;24621.261362159163;25045 13:17:53 INFO - PROCESS | 29978 | |2;jquery.html;363.7999100494729;365.4244564810424;365.8737735481258;366.61139192456;367.8160919540229;15586.84413155868;16561.17194140293;16583.751243731353;17324.307027718907;17520.21159047841;15183.392664293415;15219.368833531582;15386.61533461664;15634.530964071068;15664.451744188955;4979.502049795028;5092.872678183038;5140.588752899777;5142.485751424846;5149.356330458692;4399.2301347264265;4961.578265847407;5055.9747201263945;5067.493250674921;5441.673499590018;5230.73846307685;5370.489803468664;5395.487428694268;5429.294191755086;5432.293801805759;5307.150855863063;5337;5341.786328546854;5386.272853164812;5655.321361436613;5418.187271909206;5430.83707488776;5439.510444060014;5445.237666726662;5459.781608735646;15139;19122.61754764897;19743.80256197434;19822.10800513966;19886;1982.9504262393411;2058.361907808569;2064.762552306474;2084.247039591727;2211.7788221177916;9345.719628411158;9415.246780257632;9459.38513996588;10370.429626370547;12941.547045853444;1778.97331540027;1814.2470874587032;1828.9176987035614;1831.258340372138;1864.114545590847;54714.92098785066;56058.719706401615;56171;57064;57871.42128578702;10055.245856560641;10089.142422894136;10094.343867648726;10096.040876116756;10112.393256404639;12979.35103244834;13165.802512962313;13191.076624636184;13191.208527488381;13212.603621891358;7156.320149585781;7249.637518124073;7257.745978890714;7258.782236532807;7269.563826170447;6836.589804611739;6841.247462779091;6873.48448866337;6877.6217308048535;6894.896576551356;4336.457942757155;4373.846915357947;4399.274119770202;4500.932486012713;4511.187986162457;1758.3581992572874;1864.021388770879;1866.6173434445907;1909.0836398528784;1913.8181872722068;453.301915050818;458.05183270629476;776.689324270285;843.3548335523329;847.3009766942297;10094.899051009543;10487.790244195074;10621.150307975498;10625.734356641145;10699.358038517557;439.2159994409963;443.2354189023908;446.91508613363357;448.6343629941587;452.8505593154317;5666.263385759908;9261.953690231505;9737.367071140354;9749.512524373895;9837.60649574009;548023;554225;556449;560498;572035.2796471982;70236;70503;73182;74286.62856685682;74968.99999999891;1101.862267216598;1115.9330440173778;1124.9550017999188;1146.9254498457574;1148.615213903335;14729.779053313994;14922.701545968803;15005.324760386027;15011.699766004836;15323.693526129638;33355.1661208462;33839.15402114967;34804.82597586996;37048;37147.628523715495;43542;44985;47449.28826067681;47655.28517072316;48541.029179415505;3089.0423968569817;3099.612548431446;7983.281504664608;8795.812565303602;9640;6875.621840798604;8087.919120808952;8252.917470825456;8409.411341206056;8484.872726908978;6650.434713049445;6920.619365934922;7175.210726819942;7345.55926644403;7639.083310002835;7026.9648651756415;7305.598192099273;7584.317411432777;7627.351675107678;7717.6141192939;7005.054317667254;7018.473614478832;7184.46116541251;7523.774286771406;7581.355584775356;9791.951040244754;9858.30991830565;9924.15644670211;9928.305018648625;10035.046670566284;9435.433873967584;9618.230541556799;9675.813948858986;9704.9029509704;9803.852942206015 13:17:53 INFO - PROCESS | 29978 | |3;mootools.html;1437.6837095838914;1444.4727674398844;1580.7985930692678;1721.294269349566;1726.7927848658162;7164.534305270154;7235.204127545966;7401.8519629607445;7411.7776466705955;7471.290227428399;7386.224446433128;7422.220666829986;7448;7451.2921272479025;7474.738384156542;2312.537492501502;2316.1661801751357;2316.698829152216;2329.24299602629;2330.1727886600265;2301;2307.688462057626;2329.732080810703;2332.6501024846325;2333.94165145871;2274.7042884425;2317.9072837086583;2330.6737056811976;2332.988335058331;2342.16853017179;2284.960343043911;2296.058615967462;2302.297799171252;2323.2333330001143;2330.4523436992295;2326.6975293211945;2340.3564019894666;2342.9648555271683;2353;2364.609839376501;7299.744508942162;7321.231270716551;7338.743143989935;7343.485955983083;7366.705331786722;4592.632589392874;4679.60223381013;4698.741569213692;4711.717296962193;4723.267893476483;2940.4413161499247;2951.3507028453705;3031.8938837140595;3046.8019578727312;3063.55578441127;954.9236061115095;971.9076687714655;974.4932635029816;980.5538479991586;1014.8883622801486;10057.798844023151;10081.848772268422;10207.897921020769;10233.89766102337;10347.482625868752;4068.2880495913687;4110.301248787713;4159.438475805788;4181.832726690898;4217.599328063829;8405.117462666454;8445.366597505212;8452.788680283042;8456.365772567082;8460.661573537112;4608.861734147981;4609.101225261042;4620.8151673933335;4624.121416930772;4638.188317044571;4170.04089059518;4182.309918863414;4191.3293872980175;4219.303814870512;4235.4917409910395;3452.6547345265776;3460.7750496217664;3486.7036301914113;3493.371193185251;3502.8073455960166;1047.8323468245044;1051.04880083523;1063.2557209952909;1071.2608300272943;1080.3247970018738;1026.097034609539;1033.9121174700085;1042.9634962776267;1061.389700921973;1127.148038376472;6266.686665666698;6273.247210334698;6289.182406287154;6343.746250150035;6384.776532821422;1087.3530249501534;1095.5179720922768;1102.6030628973563;1117.9385133817718;1142.5658249864998;5086.21163719624;5215.295935048795;5241.187615919539;5248.553872920845;5280.287161233261;8637.222649961534;8894.86657700135;8992.235659968845;9071.501067441222;9120.58957346921;8990.100989901088;9001.729948101567;9019.413738107001;9037.186653201243;9055.320850936207;6753.257141714407;6887.104676392037;6896.379325860797;6989.720411183597;7008;6447.83880402975;6503.057056726842;6517.771877984248;6545.836354091186;6574.079628851869;7639.618019098912;7971.960140199262;7974.960125199337;8073.031236251452;8139.1453897339925;7929.643166057426;8202.343812494866;8224.83550329002;8246.793830154294;8318.667253310043;6282.120503129474;6293.339199383999;6394.072859435449;6501.642409667514;6520.250171230369;6670.132882725215;6702.597844129368;6764.966175169093;6766.15423072116;6783.898241526283;6454.838629034311;6505.642189679424;6577.375149360803;6579.243387010555;6660.267370589135;5834.620749651259;6034.547408944259;6219.595726277777;6297.149884765681;6419.614823110628;6175.104609831639;6197.96901015492;6234.501239900887;6353.714082866374;6392.840178995376;5913.526917846476;5945.64326140433;5954.225950626565;5961.493273071837;5966.284045914518;5967.985442474876;5972.074328479092;5972.5520585955355;5977.282726072899;6003.729832157476 13:17:53 INFO - PROCESS | 29978 | |4;prototype.html;343.6683600325685;353.8036389803658;355.98398072086746;356.6487010294857;360.44491483116;6249.593776404542;6285.811425657226;6316.715747791349;6344.968275158623;6427;6228.8131356059275;6270.874582508347;6290.716917738701;6307.180066591337;6307.716152773125;4761.928571071437;4763.356946812188;4767.475577686451;4767.69010014348;4775.570198682118;4762.523747625244;4771.403574553181;4772.451168115659;4784.043191361724;4784.856454306359;4624.953750462503;4686.484486706459;4693.953060469403;4698.214678422195;4709.788059537329;4670.416197975253;4677.906441871143;4681.461631912322;4689.507601701824;4704.623630109583;4017.417474466186;4021.416894550303;4022.6982976276895;4023.0746928206677;4027.2146931348398;5988.221531200959;5990.131430942489;5995.160677505153;5998.910016349758;6001.159837622737;5325.680459172462;5508.063629183049;5517.620594851287;5519.448055194489;5524.889502209973;6639.170103737033;6656.633885136315;6661.666916654148;6667.299933506961;6676.699548520328;4522.208613492626;4537.478190008125;4553.68124231304;4554.043650833329;4556.726596404226;6772;6898.379145876896;6931.653417329113;6942.548734332303;6958.721651133948;4711.363965864564;4712.128256272532;4715.4577223619035;4717.551832575899;4723.291506274087;4769.57073863354;4771.904561908743;4778.617710583145;4779.569838714532;4780.402449693788;5522;5523.226748255248;5523.530499907472;5524.944750552523;5526.226328314039;6572.244191917895;6590.257879656157;6667.933320666732;6689.431398331099;6692.230393504712;1651.1331550935854;1670.4404024651878;1681.6720739455934;1696.703076961527;1698.8216237295153;1127.1715289262386;1133.2237417369129;1138.3966497756203;1139.065965907964;1147.512307269407;6202.069689546604;6214.1921550198185;6240.906386404207;6244.46922011625;6258.968705156536;6800.52396332252;6869.931300686929;6870.931290687129;6878.828029299308;6885.690143943534;6102.145699602059;6213.378662133841;6223.346548612421;6223.626582405071;6239.625622462667;3669.87155449558;3688.5389326334207;3696.611855755107;3702.9074273142846;3713.795741234258;7063.117110361205;7080.2919708028785;7092.04257425241;7106.933959906056;7127.96436017827;6875.724971001104;6970.407515361251;6977.302269772982;6978.965105174543;6989.685464154125;7261.636918154071;7283.271672832674;7287.817804554928;7305.926940730631;7312.341889229995;6873.5875847449315;6884.724611015704;6935.722571097302;6947.270536593584;6954.547954382949;6652.933470665425;6812.0803691503;6881.931180688129;6894.103766510321;6900.102986611709;7243.45674074436;7244.348008679244;7283.708651653875;7288.854222915618;7296.379807716404;4700.882477938079;4748.192807222849;4750.311204875343;4757.429108507002;4759.6668233223345;6810.795676129724;6923.376896079377;6925.099737034153;6927.757528486681;7005.404540614105;6764.2559318475915;6767.89848152288;6774.220964589135;6778.830529236611;6801.387875091265;6732.865342693217;6765.560238584476;6773.05177275172;6777.93222067773;6785.38931496148;6441.645709486023;6495.350464953467;6546.574472659262;6579.934200657932;6608.471322294109;6763.12079429671;6767.898481522682;6778.3221677831825;6780;6805.693743781443;6530.738770449128;6556.672166391757;6558.934410655832;6573.5398522103;6588.143541339595 13:17:53 INFO - PROCESS | 29978 | |5;yui.html;697.532653122408;714.9070620819293;750.0624219725341;796.1799346672929;818.9058258300297;12556.309402982832;12748.362581870893;12769.48922043117;12770.233785972849;12840.357982100893;11189.104871610272;12424.875751242485;12516.186447880882;12548.686282842933;12637.747245055094;765.3723946363983;767.3285874859498;780.9492382995087;780.960951952403;781.5388920536882;764.8470305938806;767.2940894377186;768.1051574915217;772.6214155064006;775.4223103787658;801.3308887079296;804.1636697834246;805.04602046575;807.2129673568253;809.9149589293128;802.743122200896;803.1968031968032;804.5092493578942;809.5304723260524;810.1088802317404;595.502755199409;596;600.5915977135589;601.6179725874058;602.0277252237648;11899.702507437296;11980.460879260454;11980.64058078259;11985;11998.940005300004;10900.563977440894;10998.890011099948;11001.064909482704;11106.333619982826;11273.436328183558;9807.460589667566;9877.209823214125;9903.356281841658;9998.250131240113;10010.749731256778;3415.3681568909583;3466.4280393735003;3515.929681406383;3518.489818976234;3628.274345130958;45011.77494112541;45519.77240113778;46381.76809115967;46412;46428.76785616084;9267.953660231655;9435.716928492157;9715.854262186072;10072.194224462026;10203.38779673222;16476.917615411847;16478.42325518601;16498.6700265994;16522.339106435847;16595;7055.2944705529035;7198.92801071993;7284.417246620258;7291.526050806787;7645.655945482466;4014;4054.2499637567144;4093.91812163761;4111.424400583921;4136;3108.2384815720293;3118.4854499007865;3122.1414111119625;3137.733292670103;3152.8265945373223;566.4675205306999;569.0724119684887;571.9942800572024;577.5581680014792;593.7179839576166;543.8422857371318;594.6491569973737;634.1280738983897;637.6206157336377;676.2628734679125;7932.008498937633;8227.794305142299;8263.504189748634;8339.874901876477;8369.49783013021;486.0982876763623;620.444701991724;639.7971812991547;659.2168185059403;673.555453400763;3793.848246070126;4014.558398576154;4040.898977525527;4054.6350828425584;4096.426500289962;55637.44362556404;57193.428065718814;57198.14202786962;57278.7136064317;57395.713021434625;45927.081458370645;49857.25214121791;50847.7457612717;51450.74274628603;53470.19794703083;43789.78105109454;44316.55683443124;45254;45616;47089.764551177024;8351.791205219919;8586.699465518926;8879;8911.287097032351;8928.598213080557;34326;34550.30899382049;35046.12384690403;35503.627155420196;35534.822325888206;41436;41453.1709365817;44509.33236001527;44876.55123448724;45018.549814501435;9863.260255481011;9980.451075190644;10487.842682359618;10577.735556611146;10581.788364232827;11597.362145082101;11678.357690327113;11795.174337796272;13048.608541743763;13093.148945318524;10638.835615419994;10780.353178809297;10810.67567972962;10914.345139291669;10971.067459266053;11157.163212759238;11217.383043932336;11262.09903207725;11431.59989400367;11672.824907626222;10222.539985700512;10231.181505479693;10399.740006499898;10421.791564168523;10447;8557.657693692432;8774.254188393803;8859.867101993605;8944.86582701273;9301.488418137067;8445.87331190045;8447.324214062737;8920.687775927812;9134.908650913672;9159.450432974043 13:17:53 INFO - PROCESS | 29978 | __end_tp_report 13:17:53 INFO - PROCESS | 29978 | __start_cc_report 13:17:53 INFO - PROCESS | 29978 | _x_x_mozilla_cycle_collect,297 13:17:53 INFO - PROCESS | 29978 | __end_cc_report 13:17:53 INFO - PROCESS | 29978 | __startTimestamp1453411073546__endTimestamp 13:17:53 INFO - PROCESS | 29978 | 13:17:53 INFO - PROCESS | 29978 | ------- Summary: start ------- 13:17:53 INFO - PROCESS | 29978 | Number of tests: 6 13:17:53 INFO - PROCESS | 29978 | 13:17:53 INFO - PROCESS | 29978 | [#0] dojo.html Cycles:165 Average:5151.99 Median:5324.55 stddev:546.15 (10.3%) stddev-sans-first:524.95 13:17:53 INFO - PROCESS | 29978 | Values: 3158.3 3174.8 3194.9 3207.8 3211.7 5040.0 5088.9 5115.5 5126.7 5133.0 5047.8 5112.8 5121.1 5125.3 5172.0 4707.0 4716.5 4742.8 4803.6 4813.8 4774.2 4777.9 4817.5 4829.6 4856.2 4629.3 4669.3 4710.7 4738.2 4764.7 4696.0 4721.9 4722.7 4734.1 4755.3 4654.3 4701.4 4708.4 4719.5 4746.0 4911.5 4974.1 4986.8 5069.5 5115.2 5548.4 5555.9 5556.7 5579.7 5589.0 5454.9 5604.6 5608.8 5617.5 5671.5 5177.6 5243.6 5244.3 5246.0 5253.0 5683.5 5685.9 5686.7 5689.5 5694.9 5346.9 5389.1 5431.0 5437.8 5502.4 5519.8 5547.1 5554.4 5558.9 5622.8 5430.3 5436.3 5458.5 5460.6 5474.3 5390.3 5473.3 5485.1 5487.5 5545.6 4335.6 4339.6 4347.2 4369.2 4382.8 3889.9 3902.0 3905.9 3918.7 3930.9 5142.8 5160.6 5197.4 5206.7 5264.7 5579.8 5594.3 5600.0 5600.9 5615.2 5266.2 5272.3 5281.3 5282.8 5311.3 4668.3 4702.9 4716.9 4737.8 4758.8 5724.4 5754.6 5770.8 5780.8 5786.5 5554.3 5557.7 5560.7 5563.6 5582.8 5594.4 5617.4 5730.5 5737.9 5853.5 5448.4 5455.3 5455.6 5460.3 5460.8 5517.4 5518.1 5520.1 5521.1 5572.4 5312.5 5334.3 5394.0 5425.9 5470.1 5360.4 5430.0 5442.0 5444.3 5463.5 5259.4 5331.5 5336.8 5342.3 5386.7 5301.4 5361.9 5386.1 5409.8 5416.1 5300.9 5301.5 5306.5 5309.8 5324.5 13:17:53 INFO - PROCESS | 29978 | 13:17:53 INFO - PROCESS | 29978 | [#1] ext.html Cycles:180 Average:46858.40 Median:35315.47 stddev:84880.18 (240.3%) stddev-sans-first:85047.04 13:17:53 INFO - PROCESS | 29978 | Values: 537.7 562.6 588.8 593.5 602.1 33942.5 34445.9 34519.8 34601.0 34655.5 37258.8 37540.6 37600.6 37620.2 37686.1 8337.2 8445.6 8511.5 8534.6 8561.4 8319.4 8390.5 8416.8 8427.2 8457.0 8467.2 8569.4 8616.2 8628.4 8637.7 8426.1 8445.0 8499.5 8499.9 8535.0 8423.3 8513.4 8513.4 8546.6 8579.7 37174.3 37544.4 37719.6 37748.6 38021.0 2549.1 2601.2 2660.8 2666.4 3009.8 25755.9 25978.9 26012.3 26409.7 26631.5 3774.0 3921.4 3940.3 3980.9 4026.4 219434.0 220926.0 221610.0 221652.0 221687.0 50984.5 54378.5 54525.0 54811.0 54848.2 44947.0 60508.4 61113.4 61530.7 61634.0 13392.9 13434.5 13558.2 13572.2 13595.5 10298.9 10310.4 10311.8 10354.1 10372.8 18292.2 18423.2 18494.8 18509.4 18530.7 7235.3 7986.6 8158.8 8204.1 8214.5 903.5 920.6 930.3 952.4 1020.4 27110.5 27729.2 27982.9 28040.7 28053.9 1009.2 1009.4 1016.8 1019.5 1022.5 14576.9 14595.8 15022.7 15629.7 15654.8 403331.0 408803.0 410950.0 411637.0 411867.0 51134.7 51465.0 51924.5 52019.5 52107.7 1236.3 1244.9 1288.0 1298.4 1302.1 27432.5 28269.7 28700.3 28727.4 28952.0 42478.0 42953.6 43229.0 43263.8 43423.6 305335.0 306795.0 306798.0 307002.0 309144.0 28575.0 36577.8 37725.6 39937.6 41454.0 37161.3 37355.8 37425.4 37748.2 38438.8 31985.2 32511.0 32819.2 33244.3 33540.7 34748.7 34790.7 35150.0 35297.6 35333.3 33318.7 34018.5 34518.8 34542.1 34659.3 29097.6 31715.2 32004.7 32139.2 32166.7 24327.4 24562.4 24615.4 24621.3 25045.0 13:17:53 INFO - PROCESS | 29978 | 13:17:53 INFO - PROCESS | 29978 | [#2] jquery.html Cycles:180 Average:27691.02 Median:5061.73 stddev:91292.61 (1803.6%) stddev-sans-first:91525.65 13:17:53 INFO - PROCESS | 29978 | Values: 363.8 365.4 365.9 366.6 367.8 15586.8 16561.2 16583.8 17324.3 17520.2 15183.4 15219.4 15386.6 15634.5 15664.5 4979.5 5092.9 5140.6 5142.5 5149.4 4399.2 4961.6 5056.0 5067.5 5441.7 5230.7 5370.5 5395.5 5429.3 5432.3 5307.2 5337.0 5341.8 5386.3 5655.3 5418.2 5430.8 5439.5 5445.2 5459.8 15139.0 19122.6 19743.8 19822.1 19886.0 1983.0 2058.4 2064.8 2084.2 2211.8 9345.7 9415.2 9459.4 10370.4 12941.5 1779.0 1814.2 1828.9 1831.3 1864.1 54714.9 56058.7 56171.0 57064.0 57871.4 10055.2 10089.1 10094.3 10096.0 10112.4 12979.4 13165.8 13191.1 13191.2 13212.6 7156.3 7249.6 7257.7 7258.8 7269.6 6836.6 6841.2 6873.5 6877.6 6894.9 4336.5 4373.8 4399.3 4500.9 4511.2 1758.4 1864.0 1866.6 1909.1 1913.8 453.3 458.1 776.7 843.4 847.3 10094.9 10487.8 10621.2 10625.7 10699.4 439.2 443.2 446.9 448.6 452.9 5666.3 9262.0 9737.4 9749.5 9837.6 548023.0 554225.0 556449.0 560498.0 572035.3 70236.0 70503.0 73182.0 74286.6 74969.0 1101.9 1115.9 1125.0 1146.9 1148.6 14729.8 14922.7 15005.3 15011.7 15323.7 33355.2 33839.2 34804.8 37048.0 37147.6 43542.0 44985.0 47449.3 47655.3 48541.0 3089.0 3099.6 7983.3 8795.8 9640.0 6875.6 8087.9 8252.9 8409.4 8484.9 6650.4 6920.6 7175.2 7345.6 7639.1 7027.0 7305.6 7584.3 7627.4 7717.6 7005.1 7018.5 7184.5 7523.8 7581.4 9792.0 9858.3 9924.2 9928.3 10035.0 9435.4 9618.2 9675.8 9704.9 9803.9 13:17:53 INFO - PROCESS | 29978 | 13:17:53 INFO - PROCESS | 29978 | [#3] mootools.html Cycles:180 Average:5149.64 Median:5963.89 stddev:2606.95 (43.7%) stddev-sans-first:2599.33 13:17:53 INFO - PROCESS | 29978 | Values: 1437.7 1444.5 1580.8 1721.3 1726.8 7164.5 7235.2 7401.9 7411.8 7471.3 7386.2 7422.2 7448.0 7451.3 7474.7 2312.5 2316.2 2316.7 2329.2 2330.2 2301.0 2307.7 2329.7 2332.7 2333.9 2274.7 2317.9 2330.7 2333.0 2342.2 2285.0 2296.1 2302.3 2323.2 2330.5 2326.7 2340.4 2343.0 2353.0 2364.6 7299.7 7321.2 7338.7 7343.5 7366.7 4592.6 4679.6 4698.7 4711.7 4723.3 2940.4 2951.4 3031.9 3046.8 3063.6 954.9 971.9 974.5 980.6 1014.9 10057.8 10081.8 10207.9 10233.9 10347.5 4068.3 4110.3 4159.4 4181.8 4217.6 8405.1 8445.4 8452.8 8456.4 8460.7 4608.9 4609.1 4620.8 4624.1 4638.2 4170.0 4182.3 4191.3 4219.3 4235.5 3452.7 3460.8 3486.7 3493.4 3502.8 1047.8 1051.0 1063.3 1071.3 1080.3 1026.1 1033.9 1043.0 1061.4 1127.1 6266.7 6273.2 6289.2 6343.7 6384.8 1087.4 1095.5 1102.6 1117.9 1142.6 5086.2 5215.3 5241.2 5248.6 5280.3 8637.2 8894.9 8992.2 9071.5 9120.6 8990.1 9001.7 9019.4 9037.2 9055.3 6753.3 6887.1 6896.4 6989.7 7008.0 6447.8 6503.1 6517.8 6545.8 6574.1 7639.6 7972.0 7975.0 8073.0 8139.1 7929.6 8202.3 8224.8 8246.8 8318.7 6282.1 6293.3 6394.1 6501.6 6520.3 6670.1 6702.6 6765.0 6766.2 6783.9 6454.8 6505.6 6577.4 6579.2 6660.3 5834.6 6034.5 6219.6 6297.1 6419.6 6175.1 6198.0 6234.5 6353.7 6392.8 5913.5 5945.6 5954.2 5961.5 5966.3 5968.0 5972.1 5972.6 5977.3 6003.7 13:17:53 INFO - PROCESS | 29978 | 13:17:53 INFO - PROCESS | 29978 | [#4] prototype.html Cycles:180 Average:5566.04 Median:6254.28 stddev:1699.16 (27.2%) stddev-sans-first:1658.10 13:17:53 INFO - PROCESS | 29978 | Values: 343.7 353.8 356.0 356.6 360.4 6249.6 6285.8 6316.7 6345.0 6427.0 6228.8 6270.9 6290.7 6307.2 6307.7 4761.9 4763.4 4767.5 4767.7 4775.6 4762.5 4771.4 4772.5 4784.0 4784.9 4625.0 4686.5 4694.0 4698.2 4709.8 4670.4 4677.9 4681.5 4689.5 4704.6 4017.4 4021.4 4022.7 4023.1 4027.2 5988.2 5990.1 5995.2 5998.9 6001.2 5325.7 5508.1 5517.6 5519.4 5524.9 6639.2 6656.6 6661.7 6667.3 6676.7 4522.2 4537.5 4553.7 4554.0 4556.7 6772.0 6898.4 6931.7 6942.5 6958.7 4711.4 4712.1 4715.5 4717.6 4723.3 4769.6 4771.9 4778.6 4779.6 4780.4 5522.0 5523.2 5523.5 5524.9 5526.2 6572.2 6590.3 6667.9 6689.4 6692.2 1651.1 1670.4 1681.7 1696.7 1698.8 1127.2 1133.2 1138.4 1139.1 1147.5 6202.1 6214.2 6240.9 6244.5 6259.0 6800.5 6869.9 6870.9 6878.8 6885.7 6102.1 6213.4 6223.3 6223.6 6239.6 3669.9 3688.5 3696.6 3702.9 3713.8 7063.1 7080.3 7092.0 7106.9 7128.0 6875.7 6970.4 6977.3 6979.0 6989.7 7261.6 7283.3 7287.8 7305.9 7312.3 6873.6 6884.7 6935.7 6947.3 6954.5 6652.9 6812.1 6881.9 6894.1 6900.1 7243.5 7244.3 7283.7 7288.9 7296.4 4700.9 4748.2 4750.3 4757.4 4759.7 6810.8 6923.4 6925.1 6927.8 7005.4 6764.3 6767.9 6774.2 6778.8 6801.4 6732.9 6765.6 6773.1 6777.9 6785.4 6441.6 6495.4 6546.6 6579.9 6608.5 6763.1 6767.9 6778.3 6780.0 6805.7 6530.7 6556.7 6558.9 6573.5 6588.1 13:17:53 INFO - PROCESS | 29978 | 13:17:53 INFO - PROCESS | 29978 | [#5] yui.html Cycles:180 Average:13308.94 Median:46759.27 stddev:15628.71 (33.4%) stddev-sans-first:15643.86 13:17:53 INFO - PROCESS | 29978 | Values: 697.5 714.9 750.1 796.2 818.9 12556.3 12748.4 12769.5 12770.2 12840.4 11189.1 12424.9 12516.2 12548.7 12637.7 765.4 767.3 780.9 781.0 781.5 764.8 767.3 768.1 772.6 775.4 801.3 804.2 805.0 807.2 809.9 802.7 803.2 804.5 809.5 810.1 595.5 596.0 600.6 601.6 602.0 11899.7 11980.5 11980.6 11985.0 11998.9 10900.6 10998.9 11001.1 11106.3 11273.4 9807.5 9877.2 9903.4 9998.3 10010.7 3415.4 3466.4 3515.9 3518.5 3628.3 45011.8 45519.8 46381.8 46412.0 46428.8 9268.0 9435.7 9715.9 10072.2 10203.4 16476.9 16478.4 16498.7 16522.3 16595.0 7055.3 7198.9 7284.4 7291.5 7645.7 4014.0 4054.2 4093.9 4111.4 4136.0 3108.2 3118.5 3122.1 3137.7 3152.8 566.5 569.1 572.0 577.6 593.7 543.8 594.6 634.1 637.6 676.3 7932.0 8227.8 8263.5 8339.9 8369.5 486.1 620.4 639.8 659.2 673.6 3793.8 4014.6 4040.9 4054.6 4096.4 55637.4 57193.4 57198.1 57278.7 57395.7 45927.1 49857.3 50847.7 51450.7 53470.2 43789.8 44316.6 45254.0 45616.0 47089.8 8351.8 8586.7 8879.0 8911.3 8928.6 34326.0 34550.3 35046.1 35503.6 35534.8 41436.0 41453.2 44509.3 44876.6 45018.5 9863.3 9980.5 10487.8 10577.7 10581.8 11597.4 11678.4 11795.2 13048.6 13093.1 10638.8 10780.4 10810.7 10914.3 10971.1 11157.2 11217.4 11262.1 11431.6 11672.8 10222.5 10231.2 10399.7 10421.8 10447.0 8557.7 8774.3 8859.9 8944.9 9301.5 8445.9 8447.3 8920.7 9134.9 9159.5 13:17:53 INFO - PROCESS | 29978 | -------- Summary: end -------- 13:17:53 INFO - PROCESS | 29978 | 13:17:54 INFO - TEST-INFO | 29978: exit 0 13:17:54 INFO - TEST-OK | dromaeo_css | took 1109948ms 13:17:54 INFO - TEST-START | kraken 13:17:54 INFO - operating with platform_type : linux_ 13:17:54 INFO - Initialising browser for kraken test... 13:17:54 INFO - TEST-INFO | started process 30223 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsdrsW6/profile http://localhost:32849/getInfo.html) 13:17:57 INFO - PROCESS | 30223 | 13:17:57 INFO - PROCESS | 30223 | (process:30295): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:17:58 INFO - PROCESS | 30223 | __metrics Screen width/height:1600/1200 13:17:58 INFO - PROCESS | 30223 | colorDepth:24 13:17:58 INFO - PROCESS | 30223 | Browser inner width/height: 1024/697 13:17:58 INFO - PROCESS | 30223 | __metrics 13:17:58 INFO - PROCESS | 30223 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:17:59 INFO - TEST-INFO | 30223: exit 0 13:17:59 INFO - Browser initialized. 13:17:59 INFO - Running cycle 1/1 for kraken test... 13:17:59 INFO - TEST-INFO | started process 30344 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsdrsW6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:00 INFO - PROCESS | 30344 | 13:18:00 INFO - PROCESS | 30344 | (process:30402): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:18:11 INFO - PROCESS | 30344 | RSS: Main: 150654976 13:18:11 INFO - PROCESS | 30344 | 13:18:13 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32849/tests/kraken/driver.html?testName=audio-beat-detection) 13:18:14 INFO - PROCESS | 30344 | RSS: Main: 150708224 13:18:14 INFO - PROCESS | 30344 | 13:18:16 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32849/tests/kraken/driver.html?testName=audio-dft) 13:18:17 INFO - PROCESS | 30344 | RSS: Main: 154284032 13:18:17 INFO - PROCESS | 30344 | 13:18:20 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32849/tests/kraken/driver.html?testName=audio-fft) 13:18:21 INFO - PROCESS | 30344 | RSS: Main: 148156416 13:18:21 INFO - PROCESS | 30344 | 13:18:23 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32849/tests/kraken/driver.html?testName=audio-oscillator) 13:18:23 INFO - PROCESS | 30344 | RSS: Main: 148201472 13:18:23 INFO - PROCESS | 30344 | 13:18:25 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32849/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:18:26 INFO - PROCESS | 30344 | RSS: Main: 149053440 13:18:26 INFO - PROCESS | 30344 | 13:18:29 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32849/tests/kraken/driver.html?testName=imaging-darkroom) 13:18:30 INFO - PROCESS | 30344 | RSS: Main: 149602304 13:18:30 INFO - PROCESS | 30344 | 13:18:33 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32849/tests/kraken/driver.html?testName=imaging-desaturate) 13:18:33 INFO - PROCESS | 30344 | RSS: Main: 149557248 13:18:33 INFO - PROCESS | 30344 | 13:18:36 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32849/tests/kraken/driver.html?testName=json-parse-financial) 13:18:37 INFO - PROCESS | 30344 | RSS: Main: 150224896 13:18:37 INFO - PROCESS | 30344 | 13:18:38 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32849/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:18:39 INFO - PROCESS | 30344 | RSS: Main: 150032384 13:18:39 INFO - PROCESS | 30344 | 13:18:41 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:18:41 INFO - PROCESS | 30344 | RSS: Main: 149053440 13:18:41 INFO - PROCESS | 30344 | 13:18:44 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:18:44 INFO - PROCESS | 30344 | RSS: Main: 149319680 13:18:44 INFO - PROCESS | 30344 | 13:18:47 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:18:47 INFO - PROCESS | 30344 | RSS: Main: 150061056 13:18:47 INFO - PROCESS | 30344 | 13:18:50 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:18:50 INFO - PROCESS | 30344 | RSS: Main: 150544384 13:18:50 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32849/tests/kraken/driver.html?testName=ai-astar) 13:18:52 INFO - PROCESS | 30344 | RSS: Main: 149504000 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | __start_tp_report 13:18:52 INFO - PROCESS | 30344 | _x_x_mozilla_page_load 13:18:52 INFO - PROCESS | 30344 | _x_x_mozilla_page_load_details 13:18:52 INFO - PROCESS | 30344 | |i|pagename|runs| 13:18:52 INFO - PROCESS | 30344 | |0;ai-astar;111;107;112;112;112;122;111;113;112;113 13:18:52 INFO - PROCESS | 30344 | |1;audio-beat-detection;149;127;154;171;128;155;149;131;178;125 13:18:52 INFO - PROCESS | 30344 | |2;audio-dft;162;162;161;162;161;163;161;170;166;162 13:18:52 INFO - PROCESS | 30344 | |3;audio-fft;74;76;73;73;75;129;74;74;74;73 13:18:52 INFO - PROCESS | 30344 | |4;audio-oscillator;97;98;137;97;96;97;153;95;97;154 13:18:52 INFO - PROCESS | 30344 | |5;imaging-gaussian-blur;111;111;111;110;110;110;110;110;110;113 13:18:52 INFO - PROCESS | 30344 | |6;imaging-darkroom;147;146;146;146;147;146;146;148;147;146 13:18:52 INFO - PROCESS | 30344 | |7;imaging-desaturate;96;96;97;96;97;97;96;96;96;96 13:18:52 INFO - PROCESS | 30344 | |8;json-parse-financial;60;62;59;59;60;64;59;62;70;57 13:18:52 INFO - PROCESS | 30344 | |9;json-stringify-tinderbox;68;67;68;69;68;69;69;70;70;68 13:18:52 INFO - PROCESS | 30344 | |10;stanford-crypto-aes;83;80;85;84;83;83;82;83;91;83 13:18:52 INFO - PROCESS | 30344 | |11;stanford-crypto-ccm;123;124;123;130;124;115;118;120;125;125 13:18:52 INFO - PROCESS | 30344 | |12;stanford-crypto-pbkdf2;134;144;142;142;145;132;142;150;142;132 13:18:52 INFO - PROCESS | 30344 | |13;stanford-crypto-sha256-iterative;67;69;72;67;70;67;67;68;67;67 13:18:52 INFO - PROCESS | 30344 | __end_tp_report 13:18:52 INFO - PROCESS | 30344 | __start_cc_report 13:18:52 INFO - PROCESS | 30344 | _x_x_mozilla_cycle_collect,746 13:18:52 INFO - PROCESS | 30344 | __end_cc_report 13:18:52 INFO - PROCESS | 30344 | __startTimestamp1453411132711__endTimestamp 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | ------- Summary: start ------- 13:18:52 INFO - PROCESS | 30344 | Number of tests: 14 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:3.75 (3.3%) stddev-sans-first:3.94 13:18:52 INFO - PROCESS | 30344 | Values: 111.0 107.0 112.0 112.0 112.0 122.0 111.0 113.0 112.0 113.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:151.50 stddev:18.73 (12.4%) stddev-sans-first:19.85 13:18:52 INFO - PROCESS | 30344 | Values: 149.0 127.0 154.0 171.0 128.0 155.0 149.0 131.0 178.0 125.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:2.87 (1.8%) stddev-sans-first:3.02 13:18:52 INFO - PROCESS | 30344 | Values: 162.0 162.0 161.0 162.0 161.0 163.0 161.0 170.0 166.0 162.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#3] audio-fft Cycles:10 Average:79.50 Median:74.00 stddev:17.42 (23.5%) stddev-sans-first:18.36 13:18:52 INFO - PROCESS | 30344 | Values: 74.0 76.0 73.0 73.0 75.0 129.0 74.0 74.0 74.0 73.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#4] audio-oscillator Cycles:10 Average:112.10 Median:97.00 stddev:25.19 (26.0%) stddev-sans-first:26.12 13:18:52 INFO - PROCESS | 30344 | Values: 97.0 98.0 137.0 97.0 96.0 97.0 153.0 95.0 97.0 154.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.50 stddev:0.97 (0.9%) stddev-sans-first:1.01 13:18:52 INFO - PROCESS | 30344 | Values: 111.0 111.0 111.0 110.0 110.0 110.0 110.0 110.0 110.0 113.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 13:18:52 INFO - PROCESS | 30344 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 148.0 147.0 146.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:18:52 INFO - PROCESS | 30344 | Values: 96.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.00 stddev:3.68 (6.0%) stddev-sans-first:3.87 13:18:52 INFO - PROCESS | 30344 | Values: 60.0 62.0 59.0 59.0 60.0 64.0 59.0 62.0 70.0 57.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 13:18:52 INFO - PROCESS | 30344 | Values: 68.0 67.0 68.0 69.0 68.0 69.0 69.0 70.0 70.0 68.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.87 (3.5%) stddev-sans-first:3.03 13:18:52 INFO - PROCESS | 30344 | Values: 83.0 80.0 85.0 84.0 83.0 83.0 82.0 83.0 91.0 83.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:124.00 stddev:4.16 (3.4%) stddev-sans-first:4.42 13:18:52 INFO - PROCESS | 30344 | Values: 123.0 124.0 123.0 130.0 124.0 115.0 118.0 120.0 125.0 125.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:142.00 stddev:5.95 (4.2%) stddev-sans-first:5.83 13:18:52 INFO - PROCESS | 30344 | Values: 134.0 144.0 142.0 142.0 145.0 132.0 142.0 150.0 142.0 132.0 13:18:52 INFO - PROCESS | 30344 | 13:18:52 INFO - PROCESS | 30344 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:1.73 (2.6%) stddev-sans-first:1.79 13:18:52 INFO - PROCESS | 30344 | Values: 67.0 69.0 72.0 67.0 70.0 67.0 67.0 68.0 67.0 67.0 13:18:52 INFO - PROCESS | 30344 | -------- Summary: end -------- 13:18:52 INFO - PROCESS | 30344 | 13:18:53 INFO - TEST-INFO | 30344: exit 0 13:18:53 INFO - TEST-OK | kraken | took 59374ms 13:18:53 INFO - TEST-START | v8_7 13:18:53 INFO - operating with platform_type : linux_ 13:18:53 INFO - Initialising browser for v8_7 test... 13:18:53 INFO - TEST-INFO | started process 30630 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLYspxL/profile http://localhost:32849/getInfo.html) 13:18:56 INFO - PROCESS | 30630 | 13:18:56 INFO - PROCESS | 30630 | (process:30701): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:18:57 INFO - PROCESS | 30630 | __metrics Screen width/height:1600/1200 13:18:57 INFO - PROCESS | 30630 | colorDepth:24 13:18:57 INFO - PROCESS | 30630 | Browser inner width/height: 1024/697 13:18:57 INFO - PROCESS | 30630 | __metrics 13:18:57 INFO - PROCESS | 30630 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:18:58 INFO - TEST-INFO | 30630: exit 0 13:18:58 INFO - Browser initialized. 13:18:58 INFO - Running cycle 1/1 for v8_7 test... 13:18:58 INFO - TEST-INFO | started process 30750 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLYspxL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:59 INFO - PROCESS | 30750 | 13:18:59 INFO - PROCESS | 30750 | (process:30808): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:19:10 INFO - PROCESS | 30750 | RSS: Main: 150380544 13:19:10 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | Cycle 1(1): loaded http://localhost:32849/tests/v8_7/run.html (next: http://localhost:32849/tests/v8_7/run.html) 13:19:32 INFO - PROCESS | 30750 | RSS: Main: 146440192 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | __start_tp_report 13:19:32 INFO - PROCESS | 30750 | _x_x_mozilla_page_load 13:19:32 INFO - PROCESS | 30750 | _x_x_mozilla_page_load_details 13:19:32 INFO - PROCESS | 30750 | |i|pagename|runs| 13:19:32 INFO - PROCESS | 30750 | |0;Richards;167.8697330871244 13:19:32 INFO - PROCESS | 30750 | |1;DeltaBlue;188.67924528301887 13:19:32 INFO - PROCESS | 30750 | |2;Encrypt;280.58361391694723 13:19:32 INFO - PROCESS | 30750 | |3;Decrypt;5246.073298429319 13:19:32 INFO - PROCESS | 30750 | |4;RayTrace;1072.961373390558 13:19:32 INFO - PROCESS | 30750 | |5;Earley;715.307582260372 13:19:32 INFO - PROCESS | 30750 | |6;Boyer;12317.073170731708 13:19:32 INFO - PROCESS | 30750 | |7;RegExp;41489.795918367345 13:19:32 INFO - PROCESS | 30750 | |8;Splay;605.6935190793458 13:19:32 INFO - PROCESS | 30750 | |9;NavierStokes;4835.748792270531 13:19:32 INFO - PROCESS | 30750 | __end_tp_report 13:19:32 INFO - PROCESS | 30750 | __startTimestamp1453411172862__endTimestamp 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | ------- Summary: start ------- 13:19:32 INFO - PROCESS | 30750 | Number of tests: 10 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | [#0] Richards Cycles:1 Average:167.87 Median:167.87 stddev:0.00 (0.0%) 13:19:32 INFO - PROCESS | 30750 | Values: 167.9 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 13:19:32 INFO - PROCESS | 30750 | Values: 188.7 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 13:19:32 INFO - PROCESS | 30750 | Values: 280.6 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 13:19:32 INFO - PROCESS | 30750 | Values: 5246.1 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 13:19:32 INFO - PROCESS | 30750 | Values: 1073.0 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | [#5] Earley Cycles:1 Average:715.31 Median:715.31 stddev:0.00 (0.0%) 13:19:32 INFO - PROCESS | 30750 | Values: 715.3 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | [#6] Boyer Cycles:1 Average:12317.07 Median:12317.07 stddev:0.00 (0.0%) 13:19:32 INFO - PROCESS | 30750 | Values: 12317.1 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | [#7] RegExp Cycles:1 Average:41489.80 Median:41489.80 stddev:0.00 (0.0%) 13:19:32 INFO - PROCESS | 30750 | Values: 41489.8 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | [#8] Splay Cycles:1 Average:605.69 Median:605.69 stddev:0.00 (0.0%) 13:19:32 INFO - PROCESS | 30750 | Values: 605.7 13:19:32 INFO - PROCESS | 30750 | 13:19:32 INFO - PROCESS | 30750 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 13:19:32 INFO - PROCESS | 30750 | Values: 4835.7 13:19:32 INFO - PROCESS | 30750 | -------- Summary: end -------- 13:19:32 INFO - PROCESS | 30750 | 13:19:33 INFO - TEST-INFO | 30750: exit 0 13:19:33 INFO - TEST-OK | v8_7 | took 40100ms 13:19:33 INFO - SUITE-END | took 1209s 13:19:33 INFO - Completed test suite (00:20:09) 13:19:33 INFO - Working with test: dromaeo_css 13:19:33 INFO - Generating results file: dromaeo_css 13:19:33 INFO - Working with test: kraken 13:19:33 INFO - Generating results file: kraken 13:19:33 INFO - javascript benchmark 13:19:33 INFO - Working with test: v8_7 13:19:33 INFO - Generating results file: v8_7 13:19:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:19:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 13:19:34 INFO - process_Request line: dromaeo_css 6686.95 graph.html#tests=[[72,1,43]] 13:19:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:19:34 INFO - process_Request line: kraken 1512.00 graph.html#tests=[[232,1,43]] 13:19:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:19:34 INFO - process_Request line: v8_7 20287.88 graph.html#tests=[[230,1,43]] 13:19:34 INFO - RETURN: dromaeo_css: 6686.95 13:19:34 INFO - RETURN: kraken: 1512.00 13:19:34 INFO - RETURN: v8_7: 20287.88 13:19:34 INFO - javascript benchmark 13:19:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3158.3209609933874, 3174.793638413503, 3194.8722051117957, 3207.759418043647, 3211.6788321167887, 5039.974800126003, 5088.872778180547, 5115.488451154883, 5126.743662816858, 5132.974335128324, 5047.84856454306, 5112.769925353358, 5121.129408000639, 5125.28246045553, 5171.974140129303, 4707.035057813148, 4716.481187069419, 4742.810287588492, 4803.591694705954, 4813.831515896944, 4774.2122549779415, 4777.928331075037, 4817.51824817519, 4829.637777166709, 4856.17445034345, 4629.310301739857, 4669.299605059235, 4710.74090924999, 4738.218193997986, 4764.666473346867, 4696.0, 4721.929171062437, 4722.693024953367, 4734.147853386424, 4755.334253204554, 4654.2785868190485, 4701.412323459567, 4708.387909571768, 4719.504452032522, 4746.02706445178, 4911.533404326583, 4974.129527332702, 4986.82546110888, 5069.543741063285, 5115.18157094863, 5548.445155484419, 5555.861103472405, 5556.72216389183, 5579.69311687857, 5588.972055139699, 5454.945450545483, 5604.635698679573, 5608.775648974036, 5617.466340697627, 5671.461211184972, 5177.559907407875, 5243.580513558906, 5244.29202057725, 5245.9737701312015, 5253.001929633358, 5683.488486036276, 5685.886282274331, 5686.715664216773, 5689.459501347365, 5694.914576281359, 5346.8663283417445, 5389.083855744454, 5431.049566325956, 5437.809676661298, 5502.449755024546, 5519.779208831682, 5547.084731019418, 5554.444555544494, 5558.944410555923, 5622.775088996476, 5430.321209848769, 5436.266104075979, 5458.5087342139395, 5460.590455715837, 5474.343078830486, 5390.326209223847, 5473.261109750133, 5485.122380419114, 5487.506124448819, 5545.584081193927, 4335.609795118455, 4339.609435150852, 4347.217500849814, 4369.213541562485, 4382.824687012548, 3889.922201555953, 3902.0, 3905.9218815624095, 3918.686505079587, 3930.9017274568364, 5142.794288228504, 5160.612954028463, 5197.428282888879, 5206.687598744087, 5264.736763161826, 5579.776808927679, 5594.328680558359, 5600.0, 5600.943990560042, 5615.157726341, 5266.183741519994, 5272.340957380327, 5281.339832520935, 5282.788688452419, 5311.309529761106, 4668.276417155346, 4702.858914232578, 4716.882077948078, 4737.786799594027, 4758.833440829554, 5724.398938111522, 5754.625949313281, 5770.798022069207, 5780.826575202751, 5786.450287222707, 5554.305711786027, 5557.72211389437, 5560.666360018412, 5563.610547261653, 5582.776688932559, 5594.384617692132, 5617.382087970402, 5730.455606717355, 5737.9139312911175, 5853.502452291433, 5448.4006759257245, 5455.318085239345, 5455.563554915677, 5460.262864513399, 5460.781568737365, 5517.44825517445, 5518.117101263779, 5520.06158952987, 5521.116621340727, 5572.414896435978, 5312.495312945264, 5334.253204551288, 5393.9730301348245, 5425.891482170414, 5470.097433923358, 5360.41035486104, 5430.049741295336, 5442.0, 5444.265024221838, 5463.508284254277, 5259.39516955555, 5331.546818520469, 5336.7598458068705, 5342.332208473941, 5386.703731294817, 5301.443348448357, 5361.946380536145, 5386.084365657769, 5409.756560954688, 5416.106342453451, 5300.946990530046, 5301.5493683037375, 5306.52241298285, 5309.840704778863, 5324.547413469743], "unit": "score", "name": "dojo.html", "value": 5118.527678313926}, {"lowerIsBetter": false, "replicates": [537.7150110441465, 562.580877246451, 588.8174665853586, 593.5014587746292, 602.0848310567936, 33942.49086263708, 34445.89986901178, 34519.827400863025, 34601.0, 34655.480167797505, 37258.8137059315, 37540.62459375405, 37600.623993760055, 37620.24759504808, 37686.0578485538, 8337.207965243293, 8445.619947102365, 8511.489310641351, 8534.57327133644, 8561.400701950866, 8319.417640765148, 8390.454620449682, 8416.83166336673, 8427.157284271554, 8456.957715211416, 8467.153284671545, 8569.442986205877, 8616.224539791418, 8628.396012279143, 8637.697680581181, 8426.07313195548, 8445.0, 8499.532525711084, 8499.915000849975, 8534.957325213396, 8423.284020858235, 8513.361497887683, 8513.404061715682, 8546.61540230691, 8579.656813727443, 37174.32715527808, 37544.43683344752, 37719.62280377188, 37748.62251377506, 38021.0494737631, 2549.069589599783, 2601.2456387647558, 2660.840349579012, 2666.413389054405, 3009.8344591047485, 25755.871220643963, 25978.870105649352, 26012.34969125768, 26409.73590264111, 26631.467370652674, 3774.0, 3921.3529767588316, 3940.290747665419, 3980.8805735827973, 4026.4362989181536, 219434.0, 220926.0, 221610.0, 221652.0, 221687.0, 50984.49015509872, 54378.45621543813, 54525.0, 54811.0, 54848.177277340874, 44947.0, 60508.394916051155, 61113.38886611166, 61530.692346538875, 61634.0, 13392.933035334761, 13434.462621495226, 13558.186508809504, 13572.1856688599, 13595.456181752817, 10298.897011029794, 10310.43292618913, 10311.84532232017, 10354.11989980845, 10372.792544149075, 18292.17685204169, 18423.170957306953, 18494.81505184931, 18509.444716658523, 18530.722039169425, 7235.312645298688, 7986.562418764562, 8158.755237342771, 8204.138565450661, 8214.548199848947, 903.4624398482893, 920.5949382271779, 930.2511478260066, 952.3714348529937, 1020.3979652005353, 27110.457790844466, 27729.168124956283, 27982.86008569985, 28040.71959280422, 28053.859730701217, 1009.1926458832904, 1009.3590569988111, 1016.8373060310463, 1019.4749703902496, 1022.4529876516177, 14576.854231457763, 14595.78106328406, 15022.699546009018, 15629.687406252038, 15654.765178522332, 403331.0, 408803.0, 410950.0, 411637.0, 411867.0, 51134.74432627887, 51465.0, 51924.48075519272, 52019.47980520147, 52107.73946130321, 1236.2706003457822, 1244.9066320026034, 1287.9678008049686, 1298.363801737142, 1302.0755263762835, 27432.45135097247, 28269.71730282671, 28700.282492937844, 28727.425451490435, 28952.0, 42478.0, 42953.57046429496, 43229.0, 43263.78368108139, 43423.565764341954, 305335.0, 306795.0, 306798.0, 307002.0, 309144.0, 28575.0, 36577.81711091428, 37725.62274377331, 39937.600623993385, 41454.0, 37161.256774864894, 37355.81322093372, 37425.4386184202, 37748.245035099695, 38438.807805960794, 31985.18305757819, 32511.0, 32819.17952051218, 33244.33511329808, 33540.66459335473, 34748.65251347555, 34790.65209347874, 35150.0, 35297.647023530466, 35333.29333413369, 33318.666813331554, 34018.489722653685, 34518.82740586281, 34542.13644658803, 34659.30681386409, 29097.563536547394, 31715.20711982219, 32004.67995320017, 32139.196520087185, 32166.67833321637, 24327.391815204763, 24562.385940351633, 24615.38461538476, 24621.261362159163, 25045.0], "unit": "score", "name": "ext.html", "value": 17698.504792997162}, {"lowerIsBetter": false, "replicates": [363.7999100494729, 365.4244564810424, 365.8737735481258, 366.61139192456, 367.8160919540229, 15586.84413155868, 16561.17194140293, 16583.751243731353, 17324.307027718907, 17520.21159047841, 15183.392664293415, 15219.368833531582, 15386.61533461664, 15634.530964071068, 15664.451744188955, 4979.502049795028, 5092.872678183038, 5140.588752899777, 5142.485751424846, 5149.356330458692, 4399.2301347264265, 4961.578265847407, 5055.9747201263945, 5067.493250674921, 5441.673499590018, 5230.73846307685, 5370.489803468664, 5395.487428694268, 5429.294191755086, 5432.293801805759, 5307.150855863063, 5337.0, 5341.786328546854, 5386.272853164812, 5655.321361436613, 5418.187271909206, 5430.83707488776, 5439.510444060014, 5445.237666726662, 5459.781608735646, 15139.0, 19122.61754764897, 19743.80256197434, 19822.10800513966, 19886.0, 1982.9504262393411, 2058.361907808569, 2064.762552306474, 2084.247039591727, 2211.7788221177916, 9345.719628411158, 9415.246780257632, 9459.38513996588, 10370.429626370547, 12941.547045853444, 1778.97331540027, 1814.2470874587032, 1828.9176987035614, 1831.258340372138, 1864.114545590847, 54714.92098785066, 56058.719706401615, 56171.0, 57064.0, 57871.42128578702, 10055.245856560641, 10089.142422894136, 10094.343867648726, 10096.040876116756, 10112.393256404639, 12979.35103244834, 13165.802512962313, 13191.076624636184, 13191.208527488381, 13212.603621891358, 7156.320149585781, 7249.637518124073, 7257.745978890714, 7258.782236532807, 7269.563826170447, 6836.589804611739, 6841.247462779091, 6873.48448866337, 6877.6217308048535, 6894.896576551356, 4336.457942757155, 4373.846915357947, 4399.274119770202, 4500.932486012713, 4511.187986162457, 1758.3581992572874, 1864.021388770879, 1866.6173434445907, 1909.0836398528784, 1913.8181872722068, 453.301915050818, 458.05183270629476, 776.689324270285, 843.3548335523329, 847.3009766942297, 10094.899051009543, 10487.790244195074, 10621.150307975498, 10625.734356641145, 10699.358038517557, 439.2159994409963, 443.2354189023908, 446.91508613363357, 448.6343629941587, 452.8505593154317, 5666.263385759908, 9261.953690231505, 9737.367071140354, 9749.512524373895, 9837.60649574009, 548023.0, 554225.0, 556449.0, 560498.0, 572035.2796471982, 70236.0, 70503.0, 73182.0, 74286.62856685682, 74968.99999999891, 1101.862267216598, 1115.9330440173778, 1124.9550017999188, 1146.9254498457574, 1148.615213903335, 14729.779053313994, 14922.701545968803, 15005.324760386027, 15011.699766004836, 15323.693526129638, 33355.1661208462, 33839.15402114967, 34804.82597586996, 37048.0, 37147.628523715495, 43542.0, 44985.0, 47449.28826067681, 47655.28517072316, 48541.029179415505, 3089.0423968569817, 3099.612548431446, 7983.281504664608, 8795.812565303602, 9640.0, 6875.621840798604, 8087.919120808952, 8252.917470825456, 8409.411341206056, 8484.872726908978, 6650.434713049445, 6920.619365934922, 7175.210726819942, 7345.55926644403, 7639.083310002835, 7026.9648651756415, 7305.598192099273, 7584.317411432777, 7627.351675107678, 7717.6141192939, 7005.054317667254, 7018.473614478832, 7184.46116541251, 7523.774286771406, 7581.355584775356, 9791.951040244754, 9858.30991830565, 9924.15644670211, 9928.305018648625, 10035.046670566284, 9435.433873967584, 9618.230541556799, 9675.813948858986, 9704.9029509704, 9803.852942206015], "unit": "score", "name": "jquery.html", "value": 7603.603510734518}, {"lowerIsBetter": false, "replicates": [1437.6837095838914, 1444.4727674398844, 1580.7985930692678, 1721.294269349566, 1726.7927848658162, 7164.534305270154, 7235.204127545966, 7401.8519629607445, 7411.7776466705955, 7471.290227428399, 7386.224446433128, 7422.220666829986, 7448.0, 7451.2921272479025, 7474.738384156542, 2312.537492501502, 2316.1661801751357, 2316.698829152216, 2329.24299602629, 2330.1727886600265, 2301.0, 2307.688462057626, 2329.732080810703, 2332.6501024846325, 2333.94165145871, 2274.7042884425, 2317.9072837086583, 2330.6737056811976, 2332.988335058331, 2342.16853017179, 2284.960343043911, 2296.058615967462, 2302.297799171252, 2323.2333330001143, 2330.4523436992295, 2326.6975293211945, 2340.3564019894666, 2342.9648555271683, 2353.0, 2364.609839376501, 7299.744508942162, 7321.231270716551, 7338.743143989935, 7343.485955983083, 7366.705331786722, 4592.632589392874, 4679.60223381013, 4698.741569213692, 4711.717296962193, 4723.267893476483, 2940.4413161499247, 2951.3507028453705, 3031.8938837140595, 3046.8019578727312, 3063.55578441127, 954.9236061115095, 971.9076687714655, 974.4932635029816, 980.5538479991586, 1014.8883622801486, 10057.798844023151, 10081.848772268422, 10207.897921020769, 10233.89766102337, 10347.482625868752, 4068.2880495913687, 4110.301248787713, 4159.438475805788, 4181.832726690898, 4217.599328063829, 8405.117462666454, 8445.366597505212, 8452.788680283042, 8456.365772567082, 8460.661573537112, 4608.861734147981, 4609.101225261042, 4620.8151673933335, 4624.121416930772, 4638.188317044571, 4170.04089059518, 4182.309918863414, 4191.3293872980175, 4219.303814870512, 4235.4917409910395, 3452.6547345265776, 3460.7750496217664, 3486.7036301914113, 3493.371193185251, 3502.8073455960166, 1047.8323468245044, 1051.04880083523, 1063.2557209952909, 1071.2608300272943, 1080.3247970018738, 1026.097034609539, 1033.9121174700085, 1042.9634962776267, 1061.389700921973, 1127.148038376472, 6266.686665666698, 6273.247210334698, 6289.182406287154, 6343.746250150035, 6384.776532821422, 1087.3530249501534, 1095.5179720922768, 1102.6030628973563, 1117.9385133817718, 1142.5658249864998, 5086.21163719624, 5215.295935048795, 5241.187615919539, 5248.553872920845, 5280.287161233261, 8637.222649961534, 8894.86657700135, 8992.235659968845, 9071.501067441222, 9120.58957346921, 8990.100989901088, 9001.729948101567, 9019.413738107001, 9037.186653201243, 9055.320850936207, 6753.257141714407, 6887.104676392037, 6896.379325860797, 6989.720411183597, 7008.0, 6447.83880402975, 6503.057056726842, 6517.771877984248, 6545.836354091186, 6574.079628851869, 7639.618019098912, 7971.960140199262, 7974.960125199337, 8073.031236251452, 8139.1453897339925, 7929.643166057426, 8202.343812494866, 8224.83550329002, 8246.793830154294, 8318.667253310043, 6282.120503129474, 6293.339199383999, 6394.072859435449, 6501.642409667514, 6520.250171230369, 6670.132882725215, 6702.597844129368, 6764.966175169093, 6766.15423072116, 6783.898241526283, 6454.838629034311, 6505.642189679424, 6577.375149360803, 6579.243387010555, 6660.267370589135, 5834.620749651259, 6034.547408944259, 6219.595726277777, 6297.149884765681, 6419.614823110628, 6175.104609831639, 6197.96901015492, 6234.501239900887, 6353.714082866374, 6392.840178995376, 5913.526917846476, 5945.64326140433, 5954.225950626565, 5961.493273071837, 5966.284045914518, 5967.985442474876, 5972.074328479092, 5972.5520585955355, 5977.282726072899, 6003.729832157476], "unit": "score", "name": "mootools.html", "value": 4279.560981261928}, {"lowerIsBetter": false, "replicates": [343.6683600325685, 353.8036389803658, 355.98398072086746, 356.6487010294857, 360.44491483116, 6249.593776404542, 6285.811425657226, 6316.715747791349, 6344.968275158623, 6427.0, 6228.8131356059275, 6270.874582508347, 6290.716917738701, 6307.180066591337, 6307.716152773125, 4761.928571071437, 4763.356946812188, 4767.475577686451, 4767.69010014348, 4775.570198682118, 4762.523747625244, 4771.403574553181, 4772.451168115659, 4784.043191361724, 4784.856454306359, 4624.953750462503, 4686.484486706459, 4693.953060469403, 4698.214678422195, 4709.788059537329, 4670.416197975253, 4677.906441871143, 4681.461631912322, 4689.507601701824, 4704.623630109583, 4017.417474466186, 4021.416894550303, 4022.6982976276895, 4023.0746928206677, 4027.2146931348398, 5988.221531200959, 5990.131430942489, 5995.160677505153, 5998.910016349758, 6001.159837622737, 5325.680459172462, 5508.063629183049, 5517.620594851287, 5519.448055194489, 5524.889502209973, 6639.170103737033, 6656.633885136315, 6661.666916654148, 6667.299933506961, 6676.699548520328, 4522.208613492626, 4537.478190008125, 4553.68124231304, 4554.043650833329, 4556.726596404226, 6772.0, 6898.379145876896, 6931.653417329113, 6942.548734332303, 6958.721651133948, 4711.363965864564, 4712.128256272532, 4715.4577223619035, 4717.551832575899, 4723.291506274087, 4769.57073863354, 4771.904561908743, 4778.617710583145, 4779.569838714532, 4780.402449693788, 5522.0, 5523.226748255248, 5523.530499907472, 5524.944750552523, 5526.226328314039, 6572.244191917895, 6590.257879656157, 6667.933320666732, 6689.431398331099, 6692.230393504712, 1651.1331550935854, 1670.4404024651878, 1681.6720739455934, 1696.703076961527, 1698.8216237295153, 1127.1715289262386, 1133.2237417369129, 1138.3966497756203, 1139.065965907964, 1147.512307269407, 6202.069689546604, 6214.1921550198185, 6240.906386404207, 6244.46922011625, 6258.968705156536, 6800.52396332252, 6869.931300686929, 6870.931290687129, 6878.828029299308, 6885.690143943534, 6102.145699602059, 6213.378662133841, 6223.346548612421, 6223.626582405071, 6239.625622462667, 3669.87155449558, 3688.5389326334207, 3696.611855755107, 3702.9074273142846, 3713.795741234258, 7063.117110361205, 7080.2919708028785, 7092.04257425241, 7106.933959906056, 7127.96436017827, 6875.724971001104, 6970.407515361251, 6977.302269772982, 6978.965105174543, 6989.685464154125, 7261.636918154071, 7283.271672832674, 7287.817804554928, 7305.926940730631, 7312.341889229995, 6873.5875847449315, 6884.724611015704, 6935.722571097302, 6947.270536593584, 6954.547954382949, 6652.933470665425, 6812.0803691503, 6881.931180688129, 6894.103766510321, 6900.102986611709, 7243.45674074436, 7244.348008679244, 7283.708651653875, 7288.854222915618, 7296.379807716404, 4700.882477938079, 4748.192807222849, 4750.311204875343, 4757.429108507002, 4759.6668233223345, 6810.795676129724, 6923.376896079377, 6925.099737034153, 6927.757528486681, 7005.404540614105, 6764.2559318475915, 6767.89848152288, 6774.220964589135, 6778.830529236611, 6801.387875091265, 6732.865342693217, 6765.560238584476, 6773.05177275172, 6777.93222067773, 6785.38931496148, 6441.645709486023, 6495.350464953467, 6546.574472659262, 6579.934200657932, 6608.471322294109, 6763.12079429671, 6767.898481522682, 6778.3221677831825, 6780.0, 6805.693743781443, 6530.738770449128, 6556.672166391757, 6558.934410655832, 6573.5398522103, 6588.143541339595], "unit": "score", "name": "prototype.html", "value": 5015.409791693188}, {"lowerIsBetter": false, "replicates": [697.532653122408, 714.9070620819293, 750.0624219725341, 796.1799346672929, 818.9058258300297, 12556.309402982832, 12748.362581870893, 12769.48922043117, 12770.233785972849, 12840.357982100893, 11189.104871610272, 12424.875751242485, 12516.186447880882, 12548.686282842933, 12637.747245055094, 765.3723946363983, 767.3285874859498, 780.9492382995087, 780.960951952403, 781.5388920536882, 764.8470305938806, 767.2940894377186, 768.1051574915217, 772.6214155064006, 775.4223103787658, 801.3308887079296, 804.1636697834246, 805.04602046575, 807.2129673568253, 809.9149589293128, 802.743122200896, 803.1968031968032, 804.5092493578942, 809.5304723260524, 810.1088802317404, 595.502755199409, 596.0, 600.5915977135589, 601.6179725874058, 602.0277252237648, 11899.702507437296, 11980.460879260454, 11980.64058078259, 11985.0, 11998.940005300004, 10900.563977440894, 10998.890011099948, 11001.064909482704, 11106.333619982826, 11273.436328183558, 9807.460589667566, 9877.209823214125, 9903.356281841658, 9998.250131240113, 10010.749731256778, 3415.3681568909583, 3466.4280393735003, 3515.929681406383, 3518.489818976234, 3628.274345130958, 45011.77494112541, 45519.77240113778, 46381.76809115967, 46412.0, 46428.76785616084, 9267.953660231655, 9435.716928492157, 9715.854262186072, 10072.194224462026, 10203.38779673222, 16476.917615411847, 16478.42325518601, 16498.6700265994, 16522.339106435847, 16595.0, 7055.2944705529035, 7198.92801071993, 7284.417246620258, 7291.526050806787, 7645.655945482466, 4014.0, 4054.2499637567144, 4093.91812163761, 4111.424400583921, 4136.0, 3108.2384815720293, 3118.4854499007865, 3122.1414111119625, 3137.733292670103, 3152.8265945373223, 566.4675205306999, 569.0724119684887, 571.9942800572024, 577.5581680014792, 593.7179839576166, 543.8422857371318, 594.6491569973737, 634.1280738983897, 637.6206157336377, 676.2628734679125, 7932.008498937633, 8227.794305142299, 8263.504189748634, 8339.874901876477, 8369.49783013021, 486.0982876763623, 620.444701991724, 639.7971812991547, 659.2168185059403, 673.555453400763, 3793.848246070126, 4014.558398576154, 4040.898977525527, 4054.6350828425584, 4096.426500289962, 55637.44362556404, 57193.428065718814, 57198.14202786962, 57278.7136064317, 57395.713021434625, 45927.081458370645, 49857.25214121791, 50847.7457612717, 51450.74274628603, 53470.19794703083, 43789.78105109454, 44316.55683443124, 45254.0, 45616.0, 47089.764551177024, 8351.791205219919, 8586.699465518926, 8879.0, 8911.287097032351, 8928.598213080557, 34326.0, 34550.30899382049, 35046.12384690403, 35503.627155420196, 35534.822325888206, 41436.0, 41453.1709365817, 44509.33236001527, 44876.55123448724, 45018.549814501435, 9863.260255481011, 9980.451075190644, 10487.842682359618, 10577.735556611146, 10581.788364232827, 11597.362145082101, 11678.357690327113, 11795.174337796272, 13048.608541743763, 13093.148945318524, 10638.835615419994, 10780.353178809297, 10810.67567972962, 10914.345139291669, 10971.067459266053, 11157.163212759238, 11217.383043932336, 11262.09903207725, 11431.59989400367, 11672.824907626222, 10222.539985700512, 10231.181505479693, 10399.740006499898, 10421.791564168523, 10447.0, 8557.657693692432, 8774.254188393803, 8859.867101993605, 8944.86582701273, 9301.488418137067, 8445.87331190045, 8447.324214062737, 8920.687775927812, 9134.908650913672, 9159.450432974043], "unit": "score", "name": "yui.html", "value": 6046.8246541734725}], "name": "dromaeo_css", "value": 6686.956076216198}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 112.0, 112.0, 112.0, 122.0, 111.0, 113.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [149.0, 127.0, 154.0, 171.0, 128.0, 155.0, 149.0, 131.0, 178.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 163.0, 161.0, 170.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 73.0, 73.0, 75.0, 129.0, 74.0, 74.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 137.0, 97.0, 96.0, 97.0, 153.0, 95.0, 97.0, 154.0], "unit": "score", "name": "audio-oscillator", "value": 112.1}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 113.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [60.0, 62.0, 59.0, 59.0, 60.0, 64.0, 59.0, 62.0, 70.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 61.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 69.0, 68.0, 69.0, 69.0, 70.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [83.0, 80.0, 85.0, 84.0, 83.0, 83.0, 82.0, 83.0, 91.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [123.0, 124.0, 123.0, 130.0, 124.0, 115.0, 118.0, 120.0, 125.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [134.0, 144.0, 142.0, 142.0, 145.0, 132.0, 142.0, 150.0, 142.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 72.0, 67.0, 70.0, 67.0, 67.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1511.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.8697330871244], "unit": "score", "name": "Richards", "value": 210.29401399999998}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [715.307582260372], "unit": "score", "name": "Earley", "value": 931.7152739999998}, {"lowerIsBetter": false, "replicates": [12317.073170731708], "unit": "score", "name": "Boyer", "value": 54.108877227722786}, {"lowerIsBetter": false, "replicates": [41489.795918367345], "unit": "score", "name": "RegExp", "value": 21.956844564682726}, {"lowerIsBetter": false, "replicates": [605.6935190793458], "unit": "score", "name": "Splay", "value": 134.541641}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20287.87924184868}]} 13:19:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20287.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1512.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6686.95"}}} 13:19:34 INFO - Return code: 0 13:19:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:19:34 INFO - # TBPL SUCCESS # 13:19:34 INFO - Running post-action listener: _resource_record_post_action 13:19:34 INFO - Running post-run listener: _resource_record_post_run 13:19:35 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 547160064; Read time: 0; Write time: 395520 13:19:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236326912; Read time: 0; Write time: 195708 13:19:35 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 310833152; Read time: 0; Write time: 199812 13:19:35 INFO - Running post-run listener: _upload_blobber_files 13:19:35 INFO - Blob upload gear active. 13:19:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:19:35 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 13:19:35 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'] 13:19:35 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 13:19:35 INFO - (blobuploader) - INFO - Open directory for files ... 13:19:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:19:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:19:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:36 INFO - (blobuploader) - INFO - Done attempting. 13:19:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:19:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:19:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:37 INFO - (blobuploader) - INFO - Done attempting. 13:19:37 INFO - (blobuploader) - INFO - Iteration through files over. 13:19:37 INFO - Return code: 0 13:19:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:19:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:19:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1098996e99dbd521d94b1f7585522709c00c6ac6de2e006c7a87d56a7ef8f0eaa980a097b0adb083a7a4e673fc745d9a79c47074ff134e971b29a03f866ce5d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7da70dae83c8b900547bdf17221d41b2065c8133266266b4c6d30b49778473070be798375bcf269778034f4b52c72d0aff64cc215ce3727f62bdb429c6470f50"} 13:19:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:19:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:19:37 INFO - Contents: 13:19:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1098996e99dbd521d94b1f7585522709c00c6ac6de2e006c7a87d56a7ef8f0eaa980a097b0adb083a7a4e673fc745d9a79c47074ff134e971b29a03f866ce5d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7da70dae83c8b900547bdf17221d41b2065c8133266266b4c6d30b49778473070be798375bcf269778034f4b52c72d0aff64cc215ce3727f62bdb429c6470f50"} 13:19:37 INFO - Running post-run listener: copy_logs_to_upload_dir 13:19:37 INFO - Copying logs to upload dir... 13:19:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:19:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.889086 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-21 13:19:37.483925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 13:19:37.488471) ========= 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=0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1098996e99dbd521d94b1f7585522709c00c6ac6de2e006c7a87d56a7ef8f0eaa980a097b0adb083a7a4e673fc745d9a79c47074ff134e971b29a03f866ce5d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7da70dae83c8b900547bdf17221d41b2065c8133266266b4c6d30b49778473070be798375bcf269778034f4b52c72d0aff64cc215ce3727f62bdb429c6470f50"} build_url:https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/OZMZMdH7Tua1qt0056dYzw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1098996e99dbd521d94b1f7585522709c00c6ac6de2e006c7a87d56a7ef8f0eaa980a097b0adb083a7a4e673fc745d9a79c47074ff134e971b29a03f866ce5d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7da70dae83c8b900547bdf17221d41b2065c8133266266b4c6d30b49778473070be798375bcf269778034f4b52c72d0aff64cc215ce3727f62bdb429c6470f50"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 13:19:37.514256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 13:19:37.514641) ========= 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=0333a256a5e4f052382dd180000001b1-1453407408.112139-644464070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 13:19:37.598750) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 13:19:37.599228) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 13:19:37.599547) ========= ========= Total master_lag: 0.33 =========