builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1453642632.46 results: success (0) buildid: 20160124030209 builduid: 6bd0f170d093450ab0c4cc19ba0509d9 revision: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.458916) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.459520) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.459872) ========= 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=836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698 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.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.519645) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.520007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.647652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.647978) ========= 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=836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.722073) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.722418) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.722830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.723163) ========= 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=836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-24 05:37:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.9M=0s 2016-01-24 05:37:13 (34.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.910900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.911278) ========= 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=836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013440 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.962408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:12.962855) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d6d81655dd9e146c300a64c0fcaeb04ca3300a19 --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 d6d81655dd9e146c300a64c0fcaeb04ca3300a19 --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=836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-24 05:37:13,416 truncating revision to first 12 chars 2016-01-24 05:37:13,416 Setting DEBUG logging. 2016-01-24 05:37:13,416 attempt 1/10 2016-01-24 05:37:13,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d6d81655dd9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-24 05:37:13,822 unpacking tar archive at: mozilla-central-d6d81655dd9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.704575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:13.685647) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:13.686005) ========= echo d6d81655dd9e146c300a64c0fcaeb04ca3300a19 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd6d81655dd9e146c300a64c0fcaeb04ca3300a19'] 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=836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d6d81655dd9e146c300a64c0fcaeb04ca3300a19 program finished with exit code 0 elapsedTime=0.004712 script_repo_revision: 'd6d81655dd9e146c300a64c0fcaeb04ca3300a19' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:13.740241) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:13.740601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 05:37:13.775860) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-24 05:37:13.776180) ========= /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=836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:37:14 INFO - MultiFileLogger online at 20160124 05:37:14 in /builds/slave/test-pgo 05:37:14 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 05:37:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:37:14 INFO - {'append_to_log': False, 05:37:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:37:14 INFO - 'blob_upload_branch': 'Firefox', 05:37:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:37:14 INFO - 'branch': 'Firefox', 05:37:14 INFO - 'buildbot_json_path': 'buildprops.json', 05:37:14 INFO - 'config_files': ('talos/linux_config.py',), 05:37:14 INFO - 'default_actions': ('clobber', 05:37:14 INFO - 'read-buildbot-config', 05:37:14 INFO - 'download-and-extract', 05:37:14 INFO - 'populate-webroot', 05:37:14 INFO - 'create-virtualenv', 05:37:14 INFO - 'install', 05:37:14 INFO - 'run-tests'), 05:37:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:37:14 INFO - 'download_minidump_stackwalk': True, 05:37:14 INFO - 'download_symbols': 'ondemand', 05:37:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:37:14 INFO - 'tooltool.py': '/tools/tooltool.py', 05:37:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:37:14 INFO - '/tools/misc-python/virtualenv.py')}, 05:37:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:37:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:37:14 INFO - 'installer_path': 'installer.exe', 05:37:14 INFO - 'log_level': 'info', 05:37:14 INFO - 'log_name': 'talos', 05:37:14 INFO - 'log_to_console': True, 05:37:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:37:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:37:14 INFO - 'opt_config_files': (), 05:37:14 INFO - 'pip_index': False, 05:37:14 INFO - 'sps_profile': False, 05:37:14 INFO - 'sps_profile_interval': 0, 05:37:14 INFO - 'suite': 'dromaeojs-e10s', 05:37:14 INFO - 'system_bits': '32', 05:37:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:37:14 INFO - 'title': 'talos-linux64-ix-028', 05:37:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:37:14 INFO - 'use_talos_json': True, 05:37:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:37:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:37:14 INFO - 'work_dir': 'build'} 05:37:14 INFO - ##### 05:37:14 INFO - ##### Running clobber step. 05:37:14 INFO - ##### 05:37:14 INFO - Running pre-action listener: _resource_record_pre_action 05:37:14 INFO - Running main action method: clobber 05:37:14 INFO - rmtree: /builds/slave/test-pgo/build 05:37:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:37:14 INFO - Running post-action listener: _resource_record_post_action 05:37:14 INFO - ##### 05:37:14 INFO - ##### Running read-buildbot-config step. 05:37:14 INFO - ##### 05:37:14 INFO - Running pre-action listener: _resource_record_pre_action 05:37:14 INFO - Running main action method: read_buildbot_config 05:37:14 INFO - Using buildbot properties: 05:37:14 INFO - { 05:37:14 INFO - "project": "", 05:37:14 INFO - "product": "firefox", 05:37:14 INFO - "script_repo_revision": "production", 05:37:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:37:14 INFO - "repository": "", 05:37:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:37:14 INFO - "buildid": "20160124030209", 05:37:14 INFO - "stage_platform": "linux64-pgo", 05:37:14 INFO - "basedir": "/builds/slave/test-pgo", 05:37:14 INFO - "nightly_build": "True", 05:37:14 INFO - "buildnumber": 319, 05:37:14 INFO - "slavename": "talos-linux64-ix-028", 05:37:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:37:14 INFO - "platform": "ubuntu64_hw", 05:37:14 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:37:14 INFO - "branch": "mozilla-central", 05:37:14 INFO - "repo_path": "mozilla-central", 05:37:14 INFO - "revision": "d6d81655dd9e146c300a64c0fcaeb04ca3300a19", 05:37:14 INFO - "pgo_build": "True", 05:37:14 INFO - "builduid": "6bd0f170d093450ab0c4cc19ba0509d9", 05:37:14 INFO - "slavebuilddir": "test" 05:37:14 INFO - } 05:37:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:37:14 INFO - Running post-action listener: _resource_record_post_action 05:37:14 INFO - ##### 05:37:14 INFO - ##### Running download-and-extract step. 05:37:14 INFO - ##### 05:37:14 INFO - Running pre-action listener: _resource_record_pre_action 05:37:14 INFO - Running main action method: download_and_extract 05:37:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:14 INFO - https://queue.taskcluster.net/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:37:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/test_packages.json 05:37:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/test_packages.json 05:37:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:37:24 INFO - Downloaded 1448 bytes. 05:37:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:37:24 INFO - Using the following test package requirements: 05:37:24 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:24 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:37:24 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:37:24 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:24 INFO - u'jsshell-linux-x86_64.zip'], 05:37:24 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:37:24 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:24 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:37:24 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:37:24 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:37:24 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:24 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:37:24 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:24 INFO - https://queue.taskcluster.net/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/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 05:37:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/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 05:37:33 INFO - Downloaded 22490894 bytes. 05:37:33 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'] 05:37:33 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 05:37:35 INFO - Return code: 0 05:37:35 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 05:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:35 INFO - https://queue.taskcluster.net/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/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 05:37:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/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 05:37:36 INFO - Downloaded 22490894 bytes. 05:37: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'] 05:37: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 05:37:37 INFO - Return code: 0 05:37: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')]} 05:37:37 INFO - https://queue.taskcluster.net/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:37:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/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 05:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/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 05:37:38 INFO - Downloaded 10706572 bytes. 05:37:38 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'] 05:37:38 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 05:37:38 INFO - Return code: 0 05:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:38 INFO - https://queue.taskcluster.net/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:37:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/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 05:37:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqfwjRB1TV-UfdqWeHVnFg/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 05:37:40 INFO - Downloaded 55976028 bytes. 05:37:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:40 INFO - mkdir: /builds/slave/test-pgo/properties 05:37:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:37:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:37:40 INFO - Contents: 05:37:40 INFO - build_url:https://queue.taskcluster.net/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:40 INFO - Running post-action listener: _resource_record_post_action 05:37:40 INFO - Running post-action listener: set_extra_try_arguments 05:37:40 INFO - ##### 05:37:40 INFO - ##### Running populate-webroot step. 05:37:40 INFO - ##### 05:37:40 INFO - Running pre-action listener: _resource_record_pre_action 05:37:40 INFO - Running main action method: populate_webroot 05:37:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:40 INFO - '--tppagecycles', 05:37:40 INFO - '7'], 05:37:40 INFO - 'tests': ['tsvgm']}}, 05:37:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:37:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:37:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:37:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:37:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:37:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:40 INFO - 'talos_options': ['--e10s'], 05:37:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:40 INFO - 'tests': ['damp', 'tps']}, 05:37:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:40 INFO - 'talos_options': ['--e10s'], 05:37:40 INFO - 'tests': ['damp', 'tps']}, 05:37:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:37:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:40 INFO - 'other': {'tests': ['a11yr', 05:37:40 INFO - 'ts_paint', 05:37:40 INFO - 'tpaint', 05:37:40 INFO - 'sessionrestore', 05:37:40 INFO - 'sessionrestore_no_auto_restore']}, 05:37:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:37:40 INFO - 'tests': ['a11yr', 05:37:40 INFO - 'ts_paint', 05:37:40 INFO - 'tpaint', 05:37:40 INFO - 'sessionrestore', 05:37:40 INFO - 'sessionrestore_no_auto_restore']}, 05:37:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:37:40 INFO - 'tests': ['a11yr', 05:37:40 INFO - 'ts_paint', 05:37:40 INFO - 'tpaint', 05:37:40 INFO - 'sessionrestore', 05:37:40 INFO - 'sessionrestore_no_auto_restore']}, 05:37:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:37:40 INFO - 'tests': ['a11yr', 05:37:40 INFO - 'ts_paint', 05:37:40 INFO - 'tpaint', 05:37:40 INFO - 'sessionrestore', 05:37:40 INFO - 'sessionrestore_no_auto_restore']}, 05:37:40 INFO - 'other_l64': {'tests': ['a11yr', 05:37:40 INFO - 'ts_paint', 05:37:40 INFO - 'tpaint', 05:37:40 INFO - 'sessionrestore', 05:37:40 INFO - 'sessionrestore_no_auto_restore']}, 05:37:40 INFO - 'other_nol64': {'tests': ['a11yr', 05:37:40 INFO - 'ts_paint', 05:37:40 INFO - 'tpaint', 05:37:40 INFO - 'sessionrestore', 05:37:40 INFO - 'sessionrestore_no_auto_restore']}, 05:37:40 INFO - 'svgr': {'tests': ['tsvgx', 05:37:40 INFO - 'tsvgr_opacity', 05:37:40 INFO - 'tart', 05:37:40 INFO - 'tscrollx', 05:37:40 INFO - 'cart']}, 05:37:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:37:40 INFO - 'tests': ['tsvgx', 05:37:40 INFO - 'tsvgr_opacity', 05:37:40 INFO - 'tart', 05:37:40 INFO - 'tscrollx', 05:37:40 INFO - 'cart']}, 05:37:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:40 INFO - 'tests': ['tp5o']}, 05:37:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:40 INFO - 'talos_options': ['--e10s'], 05:37:40 INFO - 'tests': ['tp5o']}, 05:37:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:40 INFO - 'talos_options': ['--xperf_path', 05:37:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:40 INFO - 'tests': ['tp5n']}, 05:37:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:40 INFO - 'talos_options': ['--e10s', 05:37:40 INFO - '--xperf_path', 05:37:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:40 INFO - 'tests': ['tp5n']}}, 05:37:40 INFO - 'talos.zip': {'path': '', 05:37:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:40 INFO - Running post-action listener: _resource_record_post_action 05:37:40 INFO - ##### 05:37:40 INFO - ##### Running create-virtualenv step. 05:37:40 INFO - ##### 05:37:40 INFO - Running pre-action listener: _resource_record_pre_action 05:37:40 INFO - Running main action method: create_virtualenv 05:37:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:37:40 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 05:37:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:37:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:40 INFO - Using real prefix '/usr' 05:37:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:37:40 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:42 INFO - Installing pip.................done. 05:37:42 INFO - Return code: 0 05:37:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe017b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b38660>, '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 0x2b39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b39a10>, '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': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', '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 05:37:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:37:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:37:42 INFO - Using env: {'DISPLAY': ':0', 05:37:42 INFO - 'HOME': '/home/cltbld', 05:37:42 INFO - 'LANG': 'en_US.UTF-8', 05:37:42 INFO - 'LANGUAGE': 'en_US:en', 05:37:42 INFO - 'LOGNAME': 'cltbld', 05:37:42 INFO - 'MAIL': '/var/mail/cltbld', 05:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:42 INFO - 'MOZ_NO_REMOTE': '1', 05:37:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:42 INFO - 'NO_EM_RESTART': '1', 05:37:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:42 INFO - 'SHELL': '/bin/bash', 05:37:42 INFO - 'SHLVL': '1', 05:37:42 INFO - 'TERM': 'linux', 05:37:42 INFO - 'TMOUT': '86400', 05:37:42 INFO - 'USER': 'cltbld', 05:37:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', 05:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:42 INFO - '_': '/tools/buildbot/bin/python'} 05:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:42 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 05:37:42 INFO - Cleaning up... 05:37:42 INFO - Return code: 0 05:37:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe017b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b38660>, '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 0x2b39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b39a10>, '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': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', '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 05:37:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:37:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:37:42 INFO - Using env: {'DISPLAY': ':0', 05:37:42 INFO - 'HOME': '/home/cltbld', 05:37:42 INFO - 'LANG': 'en_US.UTF-8', 05:37:42 INFO - 'LANGUAGE': 'en_US:en', 05:37:42 INFO - 'LOGNAME': 'cltbld', 05:37:42 INFO - 'MAIL': '/var/mail/cltbld', 05:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:42 INFO - 'MOZ_NO_REMOTE': '1', 05:37:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:42 INFO - 'NO_EM_RESTART': '1', 05:37:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:42 INFO - 'SHELL': '/bin/bash', 05:37:42 INFO - 'SHLVL': '1', 05:37:42 INFO - 'TERM': 'linux', 05:37:42 INFO - 'TMOUT': '86400', 05:37:42 INFO - 'USER': 'cltbld', 05:37:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', 05:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:42 INFO - '_': '/tools/buildbot/bin/python'} 05:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:43 INFO - Downloading/unpacking psutil>=0.7.1 05:37:43 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 05:37:43 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 05:37:43 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 05:37:43 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 05:37:43 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 05:37:43 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 05:37:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:44 INFO - Installing collected packages: psutil 05:37:44 INFO - Running setup.py install for psutil 05:37:45 INFO - building 'psutil._psutil_linux' extension 05:37:45 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 05:37:45 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 05:37:45 INFO - building 'psutil._psutil_posix' extension 05:37:45 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 05:37:45 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 05:37:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:45 INFO - Successfully installed psutil 05:37:45 INFO - Cleaning up... 05:37:45 INFO - Return code: 0 05:37:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:37: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')]} 05:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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', '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 0x7ffe017b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b38660>, '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 0x2b39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b39a10>, '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': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', '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 05:37: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:37: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 mozsystemmonitor==0.0.0 05:37:45 INFO - Using env: {'DISPLAY': ':0', 05:37:45 INFO - 'HOME': '/home/cltbld', 05:37:45 INFO - 'LANG': 'en_US.UTF-8', 05:37:45 INFO - 'LANGUAGE': 'en_US:en', 05:37:45 INFO - 'LOGNAME': 'cltbld', 05:37:45 INFO - 'MAIL': '/var/mail/cltbld', 05:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:45 INFO - 'MOZ_NO_REMOTE': '1', 05:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:45 INFO - 'NO_EM_RESTART': '1', 05:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:45 INFO - 'SHELL': '/bin/bash', 05:37:45 INFO - 'SHLVL': '1', 05:37:45 INFO - 'TERM': 'linux', 05:37:45 INFO - 'TMOUT': '86400', 05:37:45 INFO - 'USER': 'cltbld', 05:37:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', 05:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:45 INFO - '_': '/tools/buildbot/bin/python'} 05:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:37:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:37:47 INFO - Installing collected packages: mozsystemmonitor 05:37:47 INFO - Running setup.py install for mozsystemmonitor 05:37:47 INFO - Successfully installed mozsystemmonitor 05:37:47 INFO - Cleaning up... 05:37:47 INFO - Return code: 0 05:37:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:47 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 0x7ffe017b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b38660>, '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 0x2b39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b39a10>, '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': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', '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 05:37:47 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 05:37:47 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 05:37:47 INFO - Using env: {'DISPLAY': ':0', 05:37:47 INFO - 'HOME': '/home/cltbld', 05:37:47 INFO - 'LANG': 'en_US.UTF-8', 05:37:47 INFO - 'LANGUAGE': 'en_US:en', 05:37:47 INFO - 'LOGNAME': 'cltbld', 05:37:47 INFO - 'MAIL': '/var/mail/cltbld', 05:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:47 INFO - 'MOZ_NO_REMOTE': '1', 05:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:47 INFO - 'NO_EM_RESTART': '1', 05:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:47 INFO - 'SHELL': '/bin/bash', 05:37:47 INFO - 'SHLVL': '1', 05:37:47 INFO - 'TERM': 'linux', 05:37:47 INFO - 'TMOUT': '86400', 05:37:47 INFO - 'USER': 'cltbld', 05:37:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', 05:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:47 INFO - '_': '/tools/buildbot/bin/python'} 05:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:37:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:37:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:37:49 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 05:37:49 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 05:37:49 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 05:37:49 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 05:37:49 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 05:37:49 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 05:37:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:37:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:50 INFO - Downloading docopt-0.6.1.tar.gz 05:37:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:37:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:37:50 INFO - Running setup.py install for blobuploader 05:37:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:37:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:37:50 INFO - Running setup.py install for requests 05:37:50 INFO - Running setup.py install for docopt 05:37:50 INFO - Successfully installed blobuploader requests docopt 05:37:50 INFO - Cleaning up... 05:37:50 INFO - Return code: 0 05:37:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:37: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')]} 05:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:50 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 0x7ffe017b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b38660>, '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 0x2b39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b39a10>, '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': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', '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 05:37:50 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 05:37:50 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 05:37:51 INFO - Using env: {'DISPLAY': ':0', 05:37:51 INFO - 'HOME': '/home/cltbld', 05:37:51 INFO - 'LANG': 'en_US.UTF-8', 05:37:51 INFO - 'LANGUAGE': 'en_US:en', 05:37:51 INFO - 'LOGNAME': 'cltbld', 05:37:51 INFO - 'MAIL': '/var/mail/cltbld', 05:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:51 INFO - 'MOZ_NO_REMOTE': '1', 05:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:51 INFO - 'NO_EM_RESTART': '1', 05:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:51 INFO - 'SHELL': '/bin/bash', 05:37:51 INFO - 'SHLVL': '1', 05:37:51 INFO - 'TERM': 'linux', 05:37:51 INFO - 'TMOUT': '86400', 05:37:51 INFO - 'USER': 'cltbld', 05:37:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', 05:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:51 INFO - '_': '/tools/buildbot/bin/python'} 05:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:51 INFO - Running setup.py (path:/tmp/pip-5acxRU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:51 INFO - Running setup.py (path:/tmp/pip-LH25PU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:51 INFO - Running setup.py (path:/tmp/pip-ybEwfx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:51 INFO - Running setup.py (path:/tmp/pip-kHAFy2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:51 INFO - Running setup.py (path:/tmp/pip-CXjees-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:51 INFO - Running setup.py (path:/tmp/pip-odGFr0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:51 INFO - Running setup.py (path:/tmp/pip-Nx7uc8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:51 INFO - Running setup.py (path:/tmp/pip-VfWeP8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:51 INFO - Running setup.py (path:/tmp/pip-4N2bBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:51 INFO - Running setup.py (path:/tmp/pip-Cs6Bx1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:51 INFO - Running setup.py (path:/tmp/pip-9bx8u8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:51 INFO - Running setup.py (path:/tmp/pip-aC1VNm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:52 INFO - Running setup.py (path:/tmp/pip-IC7qS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:52 INFO - Running setup.py (path:/tmp/pip-dOyTBe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:52 INFO - Running setup.py (path:/tmp/pip-13SZgL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:52 INFO - Running setup.py (path:/tmp/pip-Go7Zu4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:52 INFO - Running setup.py (path:/tmp/pip-drj6bg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:37:52 INFO - Running setup.py install for manifestparser 05:37:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:37:52 INFO - Running setup.py install for mozcrash 05:37:52 INFO - Running setup.py install for mozdebug 05:37:52 INFO - Running setup.py install for mozdevice 05:37:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:37:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:37:52 INFO - Running setup.py install for mozfile 05:37:52 INFO - Running setup.py install for mozhttpd 05:37:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Running setup.py install for mozinfo 05:37:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Running setup.py install for mozInstall 05:37:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Running setup.py install for mozleak 05:37:53 INFO - Running setup.py install for mozlog 05:37:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Running setup.py install for moznetwork 05:37:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Running setup.py install for mozprocess 05:37:53 INFO - Running setup.py install for mozprofile 05:37:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Running setup.py install for mozrunner 05:37:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:37:53 INFO - Running setup.py install for mozscreenshot 05:37:53 INFO - Running setup.py install for moztest 05:37:54 INFO - Running setup.py install for mozversion 05:37:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:37:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:37:54 INFO - Cleaning up... 05:37:54 INFO - Return code: 0 05:37:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:37:54 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')]} 05:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:54 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')]} 05:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:54 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 0x7ffe017b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b38660>, '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 0x2b39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b39a10>, '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': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', '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 05:37:54 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 05:37:54 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 05:37:54 INFO - Using env: {'DISPLAY': ':0', 05:37:54 INFO - 'HOME': '/home/cltbld', 05:37:54 INFO - 'LANG': 'en_US.UTF-8', 05:37:54 INFO - 'LANGUAGE': 'en_US:en', 05:37:54 INFO - 'LOGNAME': 'cltbld', 05:37:54 INFO - 'MAIL': '/var/mail/cltbld', 05:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:54 INFO - 'MOZ_NO_REMOTE': '1', 05:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:54 INFO - 'NO_EM_RESTART': '1', 05:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:54 INFO - 'SHELL': '/bin/bash', 05:37:54 INFO - 'SHLVL': '1', 05:37:54 INFO - 'TERM': 'linux', 05:37:54 INFO - 'TMOUT': '86400', 05:37:54 INFO - 'USER': 'cltbld', 05:37:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', 05:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:54 INFO - '_': '/tools/buildbot/bin/python'} 05:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:54 INFO - Running setup.py (path:/tmp/pip-1N8Vsk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:54 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)) 05:37:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:54 INFO - Running setup.py (path:/tmp/pip-wA0umy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:54 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)) 05:37:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:54 INFO - Running setup.py (path:/tmp/pip-Dfh8Oj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:54 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)) 05:37:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:54 INFO - Running setup.py (path:/tmp/pip-B6No21-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:54 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)) 05:37:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:54 INFO - Running setup.py (path:/tmp/pip-CAbTya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:54 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)) 05:37:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:54 INFO - Running setup.py (path:/tmp/pip-vk3zbq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:54 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)) 05:37:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:54 INFO - Running setup.py (path:/tmp/pip-zVnhvl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:54 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)) 05:37:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:54 INFO - Running setup.py (path:/tmp/pip-mMtk4Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:54 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)) 05:37:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:54 INFO - Running setup.py (path:/tmp/pip-RfjKSI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:55 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)) 05:37:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:55 INFO - Running setup.py (path:/tmp/pip-S88RZt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:55 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)) 05:37:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:55 INFO - Running setup.py (path:/tmp/pip-eJEJ8v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:55 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)) 05:37:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:55 INFO - Running setup.py (path:/tmp/pip-0lqN3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:55 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)) 05:37:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:55 INFO - Running setup.py (path:/tmp/pip-y16uYg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:55 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)) 05:37:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:55 INFO - Running setup.py (path:/tmp/pip-kSg8DA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:55 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)) 05:37:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:55 INFO - Running setup.py (path:/tmp/pip-UTQHEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:55 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)) 05:37:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:55 INFO - Running setup.py (path:/tmp/pip-pgUYn2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:55 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)) 05:37:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:55 INFO - Running setup.py (path:/tmp/pip-OpLhTx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:55 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)) 05:37:55 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)) 05:37:55 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)) 05:37:55 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)) 05:37:55 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)) 05:37:55 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)) 05:37:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:55 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 05:37:55 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 05:37:55 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 05:37:55 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 05:37:55 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 05:37:55 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 05:37:57 INFO - Downloading blessings-1.6.tar.gz 05:37:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:37:57 INFO - Installing collected packages: blessings 05:37:57 INFO - Running setup.py install for blessings 05:37:57 INFO - Successfully installed blessings 05:37:57 INFO - Cleaning up... 05:37:57 INFO - Return code: 0 05:37:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:37:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:37:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:37:57 INFO - Reading from file tmpfile_stdout 05:37:57 INFO - Current package versions: 05:37:57 INFO - argparse == 1.2.1 05:37:57 INFO - blessings == 1.6 05:37:57 INFO - blobuploader == 1.2.4 05:37:57 INFO - docopt == 0.6.1 05:37:57 INFO - manifestparser == 1.1 05:37:57 INFO - mozInstall == 1.12 05:37:57 INFO - mozcrash == 0.16 05:37:57 INFO - mozdebug == 0.1 05:37:57 INFO - mozdevice == 0.48 05:37:57 INFO - mozfile == 1.2 05:37:57 INFO - mozhttpd == 0.7 05:37:57 INFO - mozinfo == 0.9 05:37:57 INFO - mozleak == 0.1 05:37:57 INFO - mozlog == 3.1 05:37:57 INFO - moznetwork == 0.27 05:37:57 INFO - mozprocess == 0.22 05:37:57 INFO - mozprofile == 0.28 05:37:57 INFO - mozrunner == 6.11 05:37:57 INFO - mozscreenshot == 0.1 05:37:57 INFO - mozsystemmonitor == 0.0 05:37:57 INFO - moztest == 0.7 05:37:57 INFO - mozversion == 1.4 05:37:57 INFO - psutil == 3.1.1 05:37:57 INFO - requests == 1.2.3 05:37:57 INFO - wsgiref == 0.1.2 05:37:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:37: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')]} 05:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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/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 0x7ffe017b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b38660>, '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 0x2b39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b39a10>, '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': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', '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 05:37:57 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 05:37:57 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 05:37:57 INFO - Using env: {'DISPLAY': ':0', 05:37:57 INFO - 'HOME': '/home/cltbld', 05:37:57 INFO - 'LANG': 'en_US.UTF-8', 05:37:57 INFO - 'LANGUAGE': 'en_US:en', 05:37:57 INFO - 'LOGNAME': 'cltbld', 05:37:57 INFO - 'MAIL': '/var/mail/cltbld', 05:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:57 INFO - 'MOZ_NO_REMOTE': '1', 05:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:57 INFO - 'NO_EM_RESTART': '1', 05:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:57 INFO - 'SHELL': '/bin/bash', 05:37:57 INFO - 'SHLVL': '1', 05:37:57 INFO - 'TERM': 'linux', 05:37:57 INFO - 'TMOUT': '86400', 05:37:57 INFO - 'USER': 'cltbld', 05:37:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', 05:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:57 INFO - '_': '/tools/buildbot/bin/python'} 05:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:58 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)) 05:37:58 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)) 05:37:58 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)) 05:37:58 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)) 05:37:58 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)) 05:37:58 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)) 05:37:58 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)) 05:37:58 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)) 05:37:58 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)) 05:37:58 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)) 05:37: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:37:58 INFO - Cleaning up... 05:37:58 INFO - Return code: 0 05:37:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe017b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b38660>, '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 0x2b39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b39a10>, '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': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', '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 05:37:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:37:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:37:58 INFO - Using env: {'DISPLAY': ':0', 05:37:58 INFO - 'HOME': '/home/cltbld', 05:37:58 INFO - 'LANG': 'en_US.UTF-8', 05:37:58 INFO - 'LANGUAGE': 'en_US:en', 05:37:58 INFO - 'LOGNAME': 'cltbld', 05:37:58 INFO - 'MAIL': '/var/mail/cltbld', 05:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:58 INFO - 'MOZ_NO_REMOTE': '1', 05:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:58 INFO - 'NO_EM_RESTART': '1', 05:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:58 INFO - 'SHELL': '/bin/bash', 05:37:58 INFO - 'SHLVL': '1', 05:37:58 INFO - 'TERM': 'linux', 05:37:58 INFO - 'TMOUT': '86400', 05:37:58 INFO - 'USER': 'cltbld', 05:37:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', 05:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:58 INFO - '_': '/tools/buildbot/bin/python'} 05:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:58 INFO - Downloading/unpacking jsonschema 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:38:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:38:00 INFO - Downloading/unpacking functools32 (from jsonschema) 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:38:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:38:00 INFO - warning: no files found matching '*.txt' 05:38:00 INFO - no previously-included directories found matching 'build' 05:38:00 INFO - no previously-included directories found matching 'dist' 05:38:00 INFO - no previously-included directories found matching '.git*' 05:38:00 INFO - Installing collected packages: jsonschema, functools32 05:38:00 INFO - Running setup.py install for functools32 05:38:00 INFO - warning: no files found matching '*.txt' 05:38:00 INFO - no previously-included directories found matching 'build' 05:38:00 INFO - no previously-included directories found matching 'dist' 05:38:00 INFO - no previously-included directories found matching '.git*' 05:38:00 INFO - Successfully installed jsonschema functools32 05:38:00 INFO - Cleaning up... 05:38:00 INFO - Return code: 0 05:38:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:38: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')]} 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:00 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 0x7ffe017b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b38660>, '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 0x2b39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b39a10>, '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': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', '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 05:38:00 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 05:38:00 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 05:38:00 INFO - Using env: {'DISPLAY': ':0', 05:38:00 INFO - 'HOME': '/home/cltbld', 05:38:00 INFO - 'LANG': 'en_US.UTF-8', 05:38:00 INFO - 'LANGUAGE': 'en_US:en', 05:38:00 INFO - 'LOGNAME': 'cltbld', 05:38:00 INFO - 'MAIL': '/var/mail/cltbld', 05:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:00 INFO - 'MOZ_NO_REMOTE': '1', 05:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:00 INFO - 'NO_EM_RESTART': '1', 05:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:38:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:38:00 INFO - 'SHELL': '/bin/bash', 05:38:00 INFO - 'SHLVL': '1', 05:38:00 INFO - 'TERM': 'linux', 05:38:00 INFO - 'TMOUT': '86400', 05:38:00 INFO - 'USER': 'cltbld', 05:38:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', 05:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:00 INFO - '_': '/tools/buildbot/bin/python'} 05:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:00 INFO - Downloading/unpacking flake8 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:38:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:38:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:38:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:03 INFO - no previously-included directories found matching 'docs/_build' 05:38:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:38:03 INFO - Running setup.py install for pep8 05:38:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:03 INFO - no previously-included directories found matching 'docs/_build' 05:38:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:38:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:38:03 INFO - Cleaning up... 05:38:03 INFO - Return code: 0 05:38:03 INFO - Running post-action listener: _resource_record_post_action 05:38:03 INFO - Running post-action listener: _start_resource_monitoring 05:38:03 INFO - Starting resource monitoring. 05:38:03 INFO - ##### 05:38:03 INFO - ##### Running install step. 05:38:03 INFO - ##### 05:38:03 INFO - Running pre-action listener: _resource_record_pre_action 05:38:03 INFO - Running main action method: install 05:38:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:38:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:38:03 INFO - Reading from file tmpfile_stdout 05:38:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:38:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:38:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:38:03 INFO - Reading from file tmpfile_stdout 05:38:03 INFO - Output received: 05:38:03 INFO - Usage: mozinstall [options] installer 05:38:03 INFO - Options: 05:38:03 INFO - -h, --help show this help message and exit 05:38:03 INFO - -d DEST, --destination=DEST 05:38:03 INFO - Directory to install application into. [default: 05:38:03 INFO - "/builds/slave/test-pgo"] 05:38:03 INFO - --app=APP Application being installed. [default: firefox] 05:38:03 INFO - mkdir: /builds/slave/test-pgo/build/application 05:38:03 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'] 05:38:03 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 05:38:19 INFO - Reading from file tmpfile_stdout 05:38:19 INFO - Output received: 05:38:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:38:19 INFO - Running post-action listener: _resource_record_post_action 05:38:19 INFO - ##### 05:38:19 INFO - ##### Running run-tests step. 05:38:19 INFO - ##### 05:38:19 INFO - Running pre-action listener: _resource_record_pre_action 05:38:19 INFO - Running main action method: run_tests 05:38:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:38:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:38:19 INFO - Python 2.7.3 05:38:19 INFO - Return code: 0 05:38:19 INFO - grabbing minidump binary from tooltool 05:38:19 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')]} 05:38:19 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 0x2b38660>, '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 0x2b39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b39a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:38:19 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 05:38:19 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 05:38:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:19 INFO - Return code: 0 05:38:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:38:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:38:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:38:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:38:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:38:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:38:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:38:20 INFO - Return code: 0 05:38:20 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/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:38:20 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/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 05:38:20 INFO - Using env: {'DISPLAY': ':0', 05:38:20 INFO - 'HOME': '/home/cltbld', 05:38:20 INFO - 'LANG': 'en_US.UTF-8', 05:38:20 INFO - 'LANGUAGE': 'en_US:en', 05:38:20 INFO - 'LOGNAME': 'cltbld', 05:38:20 INFO - 'MAIL': '/var/mail/cltbld', 05:38:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:38:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:20 INFO - 'MOZ_NO_REMOTE': '1', 05:38:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:20 INFO - 'NO_EM_RESTART': '1', 05:38:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:38:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:38:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:38:20 INFO - 'SHELL': '/bin/bash', 05:38:20 INFO - 'SHLVL': '1', 05:38:20 INFO - 'TERM': 'linux', 05:38:20 INFO - 'TMOUT': '86400', 05:38:20 INFO - 'USER': 'cltbld', 05:38:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698', 05:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:20 INFO - '_': '/tools/buildbot/bin/python'} 05:38:20 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/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:38:21 INFO - mozversion application_buildid: 20160124030209 05:38:21 INFO - mozversion application_changeset: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 05:38:21 INFO - mozversion application_display_name: Nightly 05:38:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:38:21 INFO - mozversion application_name: Firefox 05:38:21 INFO - mozversion application_remotingname: firefox 05:38:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:38:21 INFO - mozversion application_vendor: Mozilla 05:38:21 INFO - mozversion application_version: 46.0a1 05:38:21 INFO - mozversion platform_buildid: 20160124030209 05:38:21 INFO - mozversion platform_changeset: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 05:38:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:38:21 INFO - mozversion platform_version: 46.0a1 05:38:21 INFO - using testdate: 1453642701 05:38:21 INFO - actual date: 1453642701 05:38:21 INFO - starting webserver on 'localhost:47920' 05:38:21 INFO - SUITE-START | Running 3 tests 05:38:21 INFO - TEST-START | dromaeo_css 05:38:21 INFO - operating with platform_type : linux_ 05:38:21 INFO - Initialising browser for dromaeo_css test... 05:38:21 INFO - TEST-INFO | started process 9505 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphA3naA/profile http://localhost:47920/getInfo.html) 05:38:24 INFO - PROCESS | 9505 | 05:38:24 INFO - PROCESS | 9505 | (process:9588): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:38:25 INFO - PROCESS | 9505 | __metrics Screen width/height:1600/1200 05:38:25 INFO - PROCESS | 9505 | colorDepth:24 05:38:25 INFO - PROCESS | 9505 | Browser inner width/height: 1024/697 05:38:25 INFO - PROCESS | 9505 | __metrics 05:38:25 INFO - PROCESS | 9505 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:38:26 INFO - TEST-INFO | 9505: exit 0 05:38:26 INFO - Browser initialized. 05:38:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:38:26 INFO - TEST-INFO | started process 9637 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphA3naA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:28 INFO - PROCESS | 9637 | 05:38:28 INFO - PROCESS | 9637 | (process:9694): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:38:38 INFO - PROCESS | 9637 | RSS: Main: 150642688 05:38:38 INFO - PROCESS | 9637 | 05:39:28 INFO - PROCESS | 9637 | 1453642768300 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] 05:41:37 INFO - PROCESS | 9637 | Cycle 1(1): loaded http://localhost:47920/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47920/tests/dromaeo/cssquery-ext.html) 05:41:38 INFO - PROCESS | 9637 | RSS: Main: 160456704 05:41:38 INFO - PROCESS | 9637 | 05:44:40 INFO - PROCESS | 9637 | Cycle 1(1): loaded http://localhost:47920/tests/dromaeo/cssquery-ext.html (next: http://localhost:47920/tests/dromaeo/cssquery-jquery.html) 05:44:41 INFO - PROCESS | 9637 | RSS: Main: 154660864 05:44:41 INFO - PROCESS | 9637 | 05:47:42 INFO - PROCESS | 9637 | Cycle 1(1): loaded http://localhost:47920/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47920/tests/dromaeo/cssquery-mootools.html) 05:47:43 INFO - PROCESS | 9637 | RSS: Main: 156696576 05:47:43 INFO - PROCESS | 9637 | 05:50:45 INFO - PROCESS | 9637 | Cycle 1(1): loaded http://localhost:47920/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47920/tests/dromaeo/cssquery-prototype.html) 05:50:45 INFO - PROCESS | 9637 | RSS: Main: 154169344 05:50:45 INFO - PROCESS | 9637 | 05:53:48 INFO - PROCESS | 9637 | Cycle 1(1): loaded http://localhost:47920/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47920/tests/dromaeo/cssquery-yui.html) 05:53:48 INFO - PROCESS | 9637 | RSS: Main: 154378240 05:53:48 INFO - PROCESS | 9637 | 05:56:51 INFO - PROCESS | 9637 | Cycle 1(1): loaded http://localhost:47920/tests/dromaeo/cssquery-yui.html (next: http://localhost:47920/tests/dromaeo/cssquery-dojo.html) 05:56:51 INFO - PROCESS | 9637 | RSS: Main: 157790208 05:56:51 INFO - PROCESS | 9637 | 05:56:51 INFO - PROCESS | 9637 | __start_tp_report 05:56:51 INFO - PROCESS | 9637 | _x_x_mozilla_page_load 05:56:51 INFO - PROCESS | 9637 | _x_x_mozilla_page_load_details 05:56:51 INFO - PROCESS | 9637 | |i|pagename|runs| 05:56:51 INFO - PROCESS | 9637 | |0;dojo.html;3138.7645926555506;3152.9999999999986;3188.2507610711464;3196.6643502432235;3218;5158.123119069758;5180.507851754087;5218.008578370107;5249.921251181236;5266.052110620087;5271.367435907697;5291.576673866091;5322.654027488211;5379.435159308275;5404;4697.788599513022;4738.147133515966;4747.240441529356;4823.927641085386;4879.707217566957;4583.220852455074;4920.876978075559;4927.088488629615;4940.925886111693;4993.051320249159;4705.976470117662;4803.423589169287;4805.567498925078;4852.02959408118;4918.286848406979;4701.717896926195;4711.081339138869;4716.268978308368;4731.172044892164;4741.834035808764;4729.810807567727;4767.451743049524;4769.809207631691;4801.783919723586;4813.927791083137;5110.28456016158;5131.281620573122;5147.047796157723;5172.715500647463;5176.767045482962;5644.407337229614;5672.744726487318;5733.397993210695;5815.331236907725;5848.707564621752;5733.541316694696;5739.942600573982;5741.598088133832;5750.1949727038245;5756.107803290455;5378.811741589065;5386.78452861885;5389.892202155935;5392.946070539284;5395.514403703646;5732.140178973187;5732.140178973187;5832.533397328203;5902.970485147547;5927.673977931169;5504.449555044544;5532;5538.9169162462595;5562.3881373048935;5610.354809196994;5581.74882130297;5652.547796176296;5656.8020119295625;5661.575381846295;5677.403872593318;5435.0488664483555;5507.504324610804;5607.186957891165;5632.324121105412;5766.826995190151;5530.5022547970875;5539.723013849372;5547.25112109868;5582.665040097607;5583.078791999355;4329.480462344539;4337.8264869404875;4341.9565804341555;4364.454443194601;4378.496472905656;3884.8251828667776;3925.568187499373;3960.6237407446247;3973.2450834341385;4009.8797036088963;5380.461953804588;5404.945950540444;5409.648372855751;5411.323584551931;5479.561635069185;5710.229119068873;5770.711464426846;5775.33583637887;5786.942130578725;5801.448862358069;5222.3733152022005;5374.516293533601;5427.213054107132;5450.754716037788;5497.39528651848;4723.055388922229;4747.561746680504;4764;4780.4741478437345;4811.350467686818;5710.543156547466;5739.426057394227;5747.827565173052;5852.063669812809;5938.495227905676;5730.484256416942;5747.655140691572;5763.423657634203;5792.420757924174;5831.387704291158;5861.296644402699;5901.675407852437;5916.585838991229;5918.437748413894;5933.465988061095;5539.362973258127;5559.471850174227;5579.553635709052;5627.943720562742;5691.089425692035;5765.654060756368;5788.189653448437;5790.9286781945475;5794.1308803679785;5822.592418530662;5623.353314368736;5638.182463542681;5655.2648155741135;5669.489745922887;5683.3748287687495;5449.809256675997;5539.750711217925;5600.991821472174;5623.718814059199;5705.62913410627;5340.385855626652;5386.326709161355;5405;5415.377231618414;5424.159255315432;5445.428230035789;5517.144842549411;5531.280933478622;5560.054790685674;5596.944030559643;5267.525922666979;5340.759665815125;5456.699881506555;5536.335639723259;5574.052411090205 05:56:51 INFO - PROCESS | 9637 | |1;ext.html;488.692123961904;531.2058472583484;533.2268211093915;538.3244028743927;554.6866020698304;36157.819210903945;36645.81677091617;36755.448668269964;36812.26375472489;36898;39358;39928;40041.799791001074;40143.39784903221;40337.798311008475;8492.830143397145;8566.614502347378;8620.439671421369;8654.913450865473;8658.696945606906;8360.498370097783;8464.66141354345;8481;8732.301415886714;8777.824443511126;8655.091215422384;8711.259542938858;8795.780105497382;8809.075047120055;8817.074207208247;8666.913330866673;8746.606402711894;8767.912320876805;8774.912250877538;8791;8579.184977427134;8648.437851539693;8655.221030107321;8695.826083478358;8741.825163496758;39614.801925990476;40217.79891100526;40353.596464035574;40372.596274037474;40382.79808600938;2965.9258518536994;3300.3069355435387;3300.950485742716;3369.1240277527772;3645.6718895299286;29361;29797.553036704467;30104.548431773543;30628.38743225123;31172;3793.279276937373;3848.615138486157;3892.8832135035996;3904.1996390739832;3914.725969182158;201318;201398.9930050355;201914;202027;202031;51318.48681513212;51629.741851290506;57105.71447142821;58674.70662646659;59175;52337.7383113082;52511.474885251424;52782.73608632009;52790.47209527856;53257.733711331195;13875.861241387658;13965.860341396456;13992.30038498071;14017.299135043411;14128.152310861382;10086.546105425274;10091.344062635904;10158;10170;10177.389356638625;19043.047847607566;19223.32718354851;19266.133024013674;19312.32406865781;19431.514212144808;7540.434467414966;7868.803279918048;7872.17342179063;7918.287354138155;7945.165757595485;857.7298151082389;866.7096522664851;1037.1961729659574;1084.983725244122;1093.8186758301015;28655.85672071668;28739.56890646642;29226.26934326616;29381.85309073441;29601;1020.1379834040224;1061.3843970497094;1064.5050051725984;1067.1676092647747;1081.5025088459397;13600.183988960496;13903.79144312836;14038.929805350908;14982.550523484313;15579.688406231811;250547;254767;255146;256234;257458;46839.531604683514;46941.06117877623;46987.765061174476;47051.058978820234;47125.764371177924;1296.935153242353;1309.6594885329882;1326.2109045118139;1343.7715588350004;1346.1250187378087;26113;28650.713492864805;29135.708642913298;29166.708332916398;30032.549511757778;43419.34870976875;43424.13151737011;43601.78199108984;43717;43798.124037518435;246995;248068;248890;250156;250432;28916.566251505825;31627.20931976627;31815;31982;32393.514097288087;37574.624253757116;37578.43632345572;38318.23363532658;38423;38582.80708596439;34412;34926.30147397089;34934.82532587321;35040.29919401547;35119.12202194965;34844.12889677778;35224.29551409009;35264;35411;35568.28863422665;34341.141471463416;35246.47130292996;35337.64662353344;35348.82325588356;35443.46834797428;31076.378472430875;31189;32048.359032818746;32235.516467252542;32359.35281294314;24056.759432406154;24460.75539244656;24597.38506537351;25258.989640414176;27046.323841903322 05:56:51 INFO - PROCESS | 9637 | |2;jquery.html;364.3332701156885;365.8609728303245;366.48691831435985;368.14773798656114;373.143635356856;16410;16550.917245413755;17186.398476053342;17465.388711395102;17901.910490447546;11464.19750617457;11832.585859494899;16342.264598093085;16351.754723679154;16374;4847.975760121194;5369.24830523727;5404.135338345865;5429.4027656957705;5432.533216031669;5254.474552544734;5428.4300148484435;5453.836384908459;5468.316460442445;5494.1758736189695;3693.076730817296;3816.313063648542;5446.7276636168235;5447.591430642698;5453.318335208099;5341.4658534146665;5490.917636235459;5494.423085576017;5523.6409633373705;5533.612647114704;5215.767158245898;5336.866578335534;5367.677939323653;5395.622306438551;5411.918821217685;15155.772663410058;19081.713774293257;19644.90177549103;19654.70517942232;19765.703514447294;2085.8748475091543;2137.8824164670937;2177.3250292409243;2260.7287125544876;2317.640765681322;9166.541672916394;9338.719838404859;9348.252139828797;9366.250699943988;9515.524223788852;1705.3690134650258;1839.2826797548967;1865.9253629854788;1876.6340563590106;1879.3891985104895;55954.72022639901;57012.42987570113;58383.41616583865;58446;58501.707491462694;10054.29619926598;10069.647562335284;10108.595656173671;10125.443100629536;10221.926697696636;13237.602871913858;13352.866471335163;13374.13068150567;13380.6654833628;13415.530456434173;7349.30181632744;7351.8162045949275;7393.260673932671;7407.074115735533;7441.702331906771;6973.965130174418;7011.859762804817;7019.087518622547;7051.717931282794;7066.823329416806;4371.103923695635;4428.911421771611;4455.688101832905;4472.172648060119;4478.104379124123;1829.9542511437055;1867.2530987605066;1868.8504919606398;1870.4108205915093;1876.2119909637984;421.5531536571183;423.3501575082234;446.187937952929;826.2811354121952;958.4441024205944;10525.947370263253;10996.725081873017;11207.943960280147;11216.551337946554;11334.43327833605;453.1458201290591;473.75601565193955;478.289739736491;483.6735203737463;486.46488862251243;5848.152017957373;6053.757849685963;6113.6331820090045;6129.938700613026;6185.134081228632;522240;528098;529506.0574091391;546194;559101;62319.376806231354;71386;73565;73831.63084184544;73869.26130738624;1095.8137116690182;1117.474786850179;1127.9323240605754;1137.6928229378186;1139.1911742662803;14352;14460.20468874222;15152.545423637308;15178.392864285746;15262.007969481949;28504.287392815346;28857;29510.852445737633;30510;30531.84734076404;36685.26629467449;36780.632193677724;36801.26397471982;36868.26263474662;39343.80328098341;4378.533191380923;4588.908221835612;7358.595277259802;7465.514741541782;7596.240375962359;9645.662401815904;10621.734456638645;10748.570057197625;11170.27393219438;11662.650120496399;9123.133302336268;9261.583228754587;9498.95250523743;9711;9767.316287859781;9476.715698529055;9655.565499552678;9811.460369679737;10031.197504199501;10172.338797978107;9088.863667045132;9487;9507.334486586149;10212.897871021194;10292.845607316047;7401.814954625962;7538.623068846646;7557.584332861746;7586.848263034598;7598.658060387185;8222.259996600334;9985;10021.09810117093;10041.196704263788;10092.89907100949 05:56:51 INFO - PROCESS | 9637 | |3;mootools.html;1443.8556144385561;1453.912765234086;1584.6909852578751;1706.6959604533888;1734.3842935757805;7512.136104348002;7630.046244219473;7651.923480765191;7844.450888437812;7852.803679907998;7745;7776.611169441534;7786.338161256286;7858.332041776442;7859.528428294307;2338.251759436981;2370.0993622423457;2373.347329484397;2374.442006128558;2376.4534157143867;2371.632396978471;2379.9643005354933;2397.808175345977;2416.516696660675;2424.2969538833718;2301.5972204864165;2321.7213934327906;2335.696359473266;2406.0736616402637;2420.782129608335;2340.169239919821;2356.917507887216;2362.232274510782;2379.6073647848084;2389.2473870730664;2378.607529757588;2396.1493669747165;2407.265783935899;2414.8068154547595;2415.4444477770035;7557.47097703161;7607.695692172307;7614.657340419639;7629.80925476862;7656.310932016146;4798.232282834764;4871.82948596801;4916.532929371704;4916.778744956449;4936.136176169192;3133.1383869436086;3166.667499912499;3229.8546565404613;3239.3683231769814;3266.526353678727;1054.3463052907246;1073.2326386633595;1077.8706555213346;1096.2874131814306;1118.4519585403093;10787.514561844735;10835.83746243807;10895.891041089646;10910.672679819618;10956.397398143099;4254.276772948606;4394.582514661102;4398.890027749268;4458.71018383804;4462.286034234507;8750.781230469289;8836.64653413869;8855.955720221358;8881.689140880038;8895.555222238861;4873.512648735098;4908.9754551227015;4910.091633047898;4943.184374578154;4971.726555039435;4516.593506584423;4526.637868970474;4539.795709193094;4583.197940360424;4583.770811459413;3581.8925432237074;3628.5282913221113;3645.0705070206927;3651.233241019416;3672.57765356982;1063.7659714862718;1124.2860783402598;1141.4121727310442;1142.8400023996646;1149.5689116581282;1092.3664274720643;1105.3478447715886;1136.9260998035102;1276.234259444326;1366.8223130992908;7204.783856484209;7251.057362542836;7287.817804554928;7295.52579082358;7303.525270857377;634.6572850660684;636.1602684456566;647.388218133859;652.5008368598026;783.9377643293369;5722.456366645162;5741.540676745851;5813.418658134237;5815.360310365856;5846.181534585162;8962.910370896338;9105.2260557852;9237.491937943343;9288.11762882525;9346.345755797029;9190.724278271662;9210.447373157633;9236.353455258202;9252;9275.443473391619;7213.567185968754;7214.639268036683;7219.0976127984;7237.927620723725;7291;7215.314545118205;7420.295071968154;7426.071741032371;7439.590822504814;7448.553086814808;8194.631241594261;8267.049289331804;8449.324054075782;8524.27543658796;8528.957355213184;8508.149185081442;8613.052564218056;8742.781430464289;8799.120087991405;8819.470831749859;6874.690638921161;6911.896321555281;6976.407005404598;7016.473764467583;7111.82220444493;7526.32263096324;7538.09542854861;7554.131274903457;7598.240175982358;7611.923880761122;6833.384995350442;6858.588484690935;7129.073220481304;7187.1734750504365;7188.101487314086;6818.624975626388;6832.077669514751;6862.382385585322;6872.347127022925;6879.8992161253955;7092.787216383516;7098.893516597358;7107.573545587281;7120.038794762848;7157.57054576727;6661.766838160641;6663.900041499284;6697.397234248941;6713.697883595152;6724.361185687352;6353.841153971188;6486.318936511599;6561.114249576246;6564.179477565304;6637.070810086495 05:56:51 INFO - PROCESS | 9637 | |4;prototype.html;350.5477933465829;350.5863081563755;354.9325628130655;356.4688613965192;357.30147561517236;6199.4110559496885;6326.082718005887;6348.619082855032;6371.585846919953;6422.710978005989;6022.909656355158;6242.656653884034;6243.344448832864;6294.464970477515;6326.841828954267;4823.903521929559;4823.903521929559;4827.51724827518;4833.419989601252;4847.733374664392;4833.7099774013495;4834.081524510332;4838.661293709424;4841.709497430148;4842.515748425165;4720.079584481027;4801.951980480203;4809.230523116302;4810.687305325143;4820.228763397857;4775.307580400857;4790.377250957388;4793.233082706785;4795.736234507101;4806.807727690888;4222.831086756526;4229.851955181584;4249.213895429355;4252.2345977724;4275.144971005811;6009.819705408801;6011.75952961881;6023.518118550505;6027.638341699512;6060.090986352038;5428.782848686048;5596.468335508121;5596.860078498029;5602.047651899146;5638.182463542805;6618.437432818217;6620.735170593171;6631.104800851872;6666.466682665424;6682.565633233873;4718.716876987358;4719.315699223594;4732.5977291929885;4732.597729193023;4737.313089601988;6709.563878347892;6940.201876784184;6942.687579059005;6969.337912898267;6980.057692211537;4669.322948172496;4741.1465936131135;4743.762811859393;4745.810167593327;4748.548887855648;4753.928691069636;4790.616750659939;4798.2082956311815;4807.567318941312;4814.446338671028;5577.3028371453565;5577.386487486455;5578.163275508706;5593;5596.412376700469;6491.415772580396;6606.141201643755;6681.9331806682285;6750.594964302158;6781.152355955505;1643.1866226218099;1669.6410271791624;1680.3362671744592;1685.4522280258966;1687.392538686072;1111.0556027376665;1121.2991880074953;1122.063077330422;1130.6070045881102;1131.7170707323169;6266.592671476339;6295.622262664255;6303.054541818764;6338.778142764981;6359.7456101755415;6865.176178858469;6871.622060786704;6872.381485666314;6874.484413668994;6892.035115083892;6149.846253843601;6277.340879207709;6281.089242059968;6312.747490100436;6347.904781428282;3768.3028639701743;3793.772373657534;3804.1060350817534;3805.353089974711;3810.466534685146;7235.38499227561;7346.302101300368;7346.33882950537;7354.816129596696;7366.189719130892;6916.20463646677;7105.182903966007;7112.0754301940415;7148.213696493382;7151.7854464366155;7295.963520182471;7297.343239108506;7303.671334789948;7314.232005639437;7319.15829679583;6930.688119034555;6950.79147625572;6970.163580370388;6971.65141742921;6977.406920411619;6734.9326506734305;6866.485013623898;6889.896651550131;6893.138357705287;6926.896096558455;7231.855362892607;7264.673089711081;7314.597697126709;7318.158411782713;7322.1579518356075;4706.670533062653;4774.522547745198;4796.472388037243;4797.496262892346;4802.183628783185;6791.456683465212;6878.449724021966;6976.407005404598;7032.296770322927;7033.542819716702;6757.560758550679;6768.763093291711;6820.045193672989;6838.247792742894;6848.7260509579055;6759.391654751096;6763.966180169067;6777.152855893013;6805.353491418307;6827.146606674166;6545.607263564201;6657.833554160991;6668.633225172662;6685.799426017227;6691.230508491391;6838.589684618939;6848.2124555674745;6856.725730970706;6863.2793556677825;6870.20992585859;6615.140031795836;6627.701753421204;6645.036469711961;6679.4990375721045;6706.362895524917 05:56:51 INFO - PROCESS | 9637 | |5;yui.html;825.925666689998;839.7732612194703;840.1010918317401;842.321930845669;850.4344610833796;13181.34093295335;13220.1406908551;13291.534796282132;13325.466981320747;13326.200427974303;11581.015613672827;11584.131190160751;11598.246114002584;11608.535658573668;11611.361375124365;659.8548319369755;668.4385116502137;803.4656953126164;818.4516374029415;821.5850995247391;803.7950322667712;806.72168102005;808.0989696488402;814.4583851738587;814.9103598604149;847.1147650704997;847.7287268074218;850.3324889961382;850.5152063323908;854.1757204297851;841.0622156295717;842.5787106446777;845.5983407881268;846.3736834742308;848.9108643592426;623.0622912516678;623.1587357067922;626.9749210031594;629.7795771479991;632.8765890651325;12536.874631253753;12543.121981461301;12556.246625202517;12593.181443206162;12695.428705708266;12481.251124932442;12629.684257893534;12729.236245825281;12769.87230127696;12816.935915320457;9783.951080244553;10522.42126683032;10633.840492392621;10660.147188224923;11003.669889903316;3493.4759786032046;3532.8056956867363;3542.096765324826;3649.9635003649887;3653.6894363978827;47579.28631070536;47628;48360;48537.27194092092;48672.75663621659;9450.385724927995;9742;9751.430242818973;10040.246981476419;10093.848592271122;17447.563810904576;17486.47540573785;17495.475135745946;17504.12479376026;17593.208305626278;7391.926080739124;7446.7021319146625;7460.104787425544;7460.738874139379;7472.364848987788;4015.658669013108;4018.7588744675413;4083.3670781028986;4154.813033413504;4204.096119334357;2962.1113665900575;2998.220462679719;3017.5473678947897;3020.562018507304;3035.104644129987;570.2273419516579;578.3666884761179;585.8857522783017;590.8138936235072;591.1723586978179;516.3210378352454;545.4463719324889;584.6112335297065;624.4816802054283;668.8428219368444;8144.674213031531;8183;8323.791905202419;9068.410553314014;9122.589483473259;516.5012739042903;520.1183993131606;543.6086018066985;629.8582818865718;683.8256244657581;3662.377395842713;3753.962460375416;3807.485989391452;3827.936489022639;3876.4960555127655;50959.235611465854;51013.48986510162;51402.22896656553;51480;51513;49758;49887.25169122466;50279.74860125676;50771.746141269796;50854.49145508498;44920;45630;46737.29894051592;47417.525824742;47431.762841184885;8575.31397488187;8789.516576588348;8856.468611883307;8961.417507861968;8987.910120898707;33703.79813917674;33842.32315353728;34611.653883460844;34917.650823491436;35096;38974.22051558896;39331.410028850165;41949.580504194564;42069;42358.78820605877;10851.348919064882;10874.347539147677;10894.836577451502;10913.40568557571;11085.113190944543;11308.151888608223;11313.377764223047;11358.204925655125;11648.708782280512;11680.532778689098;11227.607033753779;11254.662360129209;11354.318740875575;11674.066074714172;11724.179307448738;11337.26307789991;11566.537338506365;11621.88378116208;11943.641690749291;11994.700132496408;10420.947895260475;10923.836142458029;11024;11387.889688249203;11421.200515964136;9381.233543445174;9411.670591529264;9412.388194767318;9534.761630959281;9849.113579777855;8764.21122099014;9017;9120.315976301936;9163.175314221751;9661.227101831977 05:56:51 INFO - PROCESS | 9637 | __end_tp_report 05:56:51 INFO - PROCESS | 9637 | __start_cc_report 05:56:51 INFO - PROCESS | 9637 | _x_x_mozilla_cycle_collect,313 05:56:51 INFO - PROCESS | 9637 | __end_cc_report 05:56:51 INFO - PROCESS | 9637 | __startTimestamp1453643811531__endTimestamp 05:56:51 INFO - PROCESS | 9637 | 05:56:51 INFO - PROCESS | 9637 | ------- Summary: start ------- 05:56:51 INFO - PROCESS | 9637 | Number of tests: 6 05:56:51 INFO - PROCESS | 9637 | 05:56:51 INFO - PROCESS | 9637 | [#0] dojo.html Cycles:165 Average:5272.61 Median:5450.75 stddev:595.69 (10.9%) stddev-sans-first:573.51 05:56:51 INFO - PROCESS | 9637 | Values: 3138.8 3153.0 3188.3 3196.7 3218.0 5158.1 5180.5 5218.0 5249.9 5266.1 5271.4 5291.6 5322.7 5379.4 5404.0 4697.8 4738.1 4747.2 4823.9 4879.7 4583.2 4920.9 4927.1 4940.9 4993.1 4706.0 4803.4 4805.6 4852.0 4918.3 4701.7 4711.1 4716.3 4731.2 4741.8 4729.8 4767.5 4769.8 4801.8 4813.9 5110.3 5131.3 5147.0 5172.7 5176.8 5644.4 5672.7 5733.4 5815.3 5848.7 5733.5 5739.9 5741.6 5750.2 5756.1 5378.8 5386.8 5389.9 5392.9 5395.5 5732.1 5732.1 5832.5 5903.0 5927.7 5504.4 5532.0 5538.9 5562.4 5610.4 5581.7 5652.5 5656.8 5661.6 5677.4 5435.0 5507.5 5607.2 5632.3 5766.8 5530.5 5539.7 5547.3 5582.7 5583.1 4329.5 4337.8 4342.0 4364.5 4378.5 3884.8 3925.6 3960.6 3973.2 4009.9 5380.5 5404.9 5409.6 5411.3 5479.6 5710.2 5770.7 5775.3 5786.9 5801.4 5222.4 5374.5 5427.2 5450.8 5497.4 4723.1 4747.6 4764.0 4780.5 4811.4 5710.5 5739.4 5747.8 5852.1 5938.5 5730.5 5747.7 5763.4 5792.4 5831.4 5861.3 5901.7 5916.6 5918.4 5933.5 5539.4 5559.5 5579.6 5627.9 5691.1 5765.7 5788.2 5790.9 5794.1 5822.6 5623.4 5638.2 5655.3 5669.5 5683.4 5449.8 5539.8 5601.0 5623.7 5705.6 5340.4 5386.3 5405.0 5415.4 5424.2 5445.4 5517.1 5531.3 5560.1 5596.9 5267.5 5340.8 5456.7 5536.3 5574.1 05:56:51 INFO - PROCESS | 9637 | 05:56:51 INFO - PROCESS | 9637 | [#1] ext.html Cycles:180 Average:40577.53 Median:35255.24 stddev:61310.08 (173.9%) stddev-sans-first:61408.18 05:56:51 INFO - PROCESS | 9637 | Values: 488.7 531.2 533.2 538.3 554.7 36157.8 36645.8 36755.4 36812.3 36898.0 39358.0 39928.0 40041.8 40143.4 40337.8 8492.8 8566.6 8620.4 8654.9 8658.7 8360.5 8464.7 8481.0 8732.3 8777.8 8655.1 8711.3 8795.8 8809.1 8817.1 8666.9 8746.6 8767.9 8774.9 8791.0 8579.2 8648.4 8655.2 8695.8 8741.8 39614.8 40217.8 40353.6 40372.6 40382.8 2965.9 3300.3 3301.0 3369.1 3645.7 29361.0 29797.6 30104.5 30628.4 31172.0 3793.3 3848.6 3892.9 3904.2 3914.7 201318.0 201399.0 201914.0 202027.0 202031.0 51318.5 51629.7 57105.7 58674.7 59175.0 52337.7 52511.5 52782.7 52790.5 53257.7 13875.9 13965.9 13992.3 14017.3 14128.2 10086.5 10091.3 10158.0 10170.0 10177.4 19043.0 19223.3 19266.1 19312.3 19431.5 7540.4 7868.8 7872.2 7918.3 7945.2 857.7 866.7 1037.2 1085.0 1093.8 28655.9 28739.6 29226.3 29381.9 29601.0 1020.1 1061.4 1064.5 1067.2 1081.5 13600.2 13903.8 14038.9 14982.6 15579.7 250547.0 254767.0 255146.0 256234.0 257458.0 46839.5 46941.1 46987.8 47051.1 47125.8 1296.9 1309.7 1326.2 1343.8 1346.1 26113.0 28650.7 29135.7 29166.7 30032.5 43419.3 43424.1 43601.8 43717.0 43798.1 246995.0 248068.0 248890.0 250156.0 250432.0 28916.6 31627.2 31815.0 31982.0 32393.5 37574.6 37578.4 38318.2 38423.0 38582.8 34412.0 34926.3 34934.8 35040.3 35119.1 34844.1 35224.3 35264.0 35411.0 35568.3 34341.1 35246.5 35337.6 35348.8 35443.5 31076.4 31189.0 32048.4 32235.5 32359.4 24056.8 24460.8 24597.4 25259.0 27046.3 05:56:51 INFO - PROCESS | 9637 | 05:56:51 INFO - PROCESS | 9637 | [#2] jquery.html Cycles:180 Average:26792.49 Median:4475.14 stddev:87783.06 (1961.6%) stddev-sans-first:88006.88 05:56:51 INFO - PROCESS | 9637 | Values: 364.3 365.9 366.5 368.1 373.1 16410.0 16550.9 17186.4 17465.4 17901.9 11464.2 11832.6 16342.3 16351.8 16374.0 4848.0 5369.2 5404.1 5429.4 5432.5 5254.5 5428.4 5453.8 5468.3 5494.2 3693.1 3816.3 5446.7 5447.6 5453.3 5341.5 5490.9 5494.4 5523.6 5533.6 5215.8 5336.9 5367.7 5395.6 5411.9 15155.8 19081.7 19644.9 19654.7 19765.7 2085.9 2137.9 2177.3 2260.7 2317.6 9166.5 9338.7 9348.3 9366.3 9515.5 1705.4 1839.3 1865.9 1876.6 1879.4 55954.7 57012.4 58383.4 58446.0 58501.7 10054.3 10069.6 10108.6 10125.4 10221.9 13237.6 13352.9 13374.1 13380.7 13415.5 7349.3 7351.8 7393.3 7407.1 7441.7 6974.0 7011.9 7019.1 7051.7 7066.8 4371.1 4428.9 4455.7 4472.2 4478.1 1830.0 1867.3 1868.9 1870.4 1876.2 421.6 423.4 446.2 826.3 958.4 10525.9 10996.7 11207.9 11216.6 11334.4 453.1 473.8 478.3 483.7 486.5 5848.2 6053.8 6113.6 6129.9 6185.1 522240.0 528098.0 529506.1 546194.0 559101.0 62319.4 71386.0 73565.0 73831.6 73869.3 1095.8 1117.5 1127.9 1137.7 1139.2 14352.0 14460.2 15152.5 15178.4 15262.0 28504.3 28857.0 29510.9 30510.0 30531.8 36685.3 36780.6 36801.3 36868.3 39343.8 4378.5 4588.9 7358.6 7465.5 7596.2 9645.7 10621.7 10748.6 11170.3 11662.7 9123.1 9261.6 9499.0 9711.0 9767.3 9476.7 9655.6 9811.5 10031.2 10172.3 9088.9 9487.0 9507.3 10212.9 10292.8 7401.8 7538.6 7557.6 7586.8 7598.7 8222.3 9985.0 10021.1 10041.2 10092.9 05:56:51 INFO - PROCESS | 9637 | 05:56:51 INFO - PROCESS | 9637 | [#3] mootools.html Cycles:180 Average:5498.33 Median:3606.81 stddev:2809.92 (77.9%) stddev-sans-first:2801.28 05:56:51 INFO - PROCESS | 9637 | Values: 1443.9 1453.9 1584.7 1706.7 1734.4 7512.1 7630.0 7651.9 7844.5 7852.8 7745.0 7776.6 7786.3 7858.3 7859.5 2338.3 2370.1 2373.3 2374.4 2376.5 2371.6 2380.0 2397.8 2416.5 2424.3 2301.6 2321.7 2335.7 2406.1 2420.8 2340.2 2356.9 2362.2 2379.6 2389.2 2378.6 2396.1 2407.3 2414.8 2415.4 7557.5 7607.7 7614.7 7629.8 7656.3 4798.2 4871.8 4916.5 4916.8 4936.1 3133.1 3166.7 3229.9 3239.4 3266.5 1054.3 1073.2 1077.9 1096.3 1118.5 10787.5 10835.8 10895.9 10910.7 10956.4 4254.3 4394.6 4398.9 4458.7 4462.3 8750.8 8836.6 8856.0 8881.7 8895.6 4873.5 4909.0 4910.1 4943.2 4971.7 4516.6 4526.6 4539.8 4583.2 4583.8 3581.9 3628.5 3645.1 3651.2 3672.6 1063.8 1124.3 1141.4 1142.8 1149.6 1092.4 1105.3 1136.9 1276.2 1366.8 7204.8 7251.1 7287.8 7295.5 7303.5 634.7 636.2 647.4 652.5 783.9 5722.5 5741.5 5813.4 5815.4 5846.2 8962.9 9105.2 9237.5 9288.1 9346.3 9190.7 9210.4 9236.4 9252.0 9275.4 7213.6 7214.6 7219.1 7237.9 7291.0 7215.3 7420.3 7426.1 7439.6 7448.6 8194.6 8267.0 8449.3 8524.3 8529.0 8508.1 8613.1 8742.8 8799.1 8819.5 6874.7 6911.9 6976.4 7016.5 7111.8 7526.3 7538.1 7554.1 7598.2 7611.9 6833.4 6858.6 7129.1 7187.2 7188.1 6818.6 6832.1 6862.4 6872.3 6879.9 7092.8 7098.9 7107.6 7120.0 7157.6 6661.8 6663.9 6697.4 6713.7 6724.4 6353.8 6486.3 6561.1 6564.2 6637.1 05:56:51 INFO - PROCESS | 9637 | 05:56:51 INFO - PROCESS | 9637 | [#4] prototype.html Cycles:180 Average:5622.88 Median:6307.90 stddev:1704.10 (27.0%) stddev-sans-first:1662.29 05:56:51 INFO - PROCESS | 9637 | Values: 350.5 350.6 354.9 356.5 357.3 6199.4 6326.1 6348.6 6371.6 6422.7 6022.9 6242.7 6243.3 6294.5 6326.8 4823.9 4823.9 4827.5 4833.4 4847.7 4833.7 4834.1 4838.7 4841.7 4842.5 4720.1 4802.0 4809.2 4810.7 4820.2 4775.3 4790.4 4793.2 4795.7 4806.8 4222.8 4229.9 4249.2 4252.2 4275.1 6009.8 6011.8 6023.5 6027.6 6060.1 5428.8 5596.5 5596.9 5602.0 5638.2 6618.4 6620.7 6631.1 6666.5 6682.6 4718.7 4719.3 4732.6 4732.6 4737.3 6709.6 6940.2 6942.7 6969.3 6980.1 4669.3 4741.1 4743.8 4745.8 4748.5 4753.9 4790.6 4798.2 4807.6 4814.4 5577.3 5577.4 5578.2 5593.0 5596.4 6491.4 6606.1 6681.9 6750.6 6781.2 1643.2 1669.6 1680.3 1685.5 1687.4 1111.1 1121.3 1122.1 1130.6 1131.7 6266.6 6295.6 6303.1 6338.8 6359.7 6865.2 6871.6 6872.4 6874.5 6892.0 6149.8 6277.3 6281.1 6312.7 6347.9 3768.3 3793.8 3804.1 3805.4 3810.5 7235.4 7346.3 7346.3 7354.8 7366.2 6916.2 7105.2 7112.1 7148.2 7151.8 7296.0 7297.3 7303.7 7314.2 7319.2 6930.7 6950.8 6970.2 6971.7 6977.4 6734.9 6866.5 6889.9 6893.1 6926.9 7231.9 7264.7 7314.6 7318.2 7322.2 4706.7 4774.5 4796.5 4797.5 4802.2 6791.5 6878.4 6976.4 7032.3 7033.5 6757.6 6768.8 6820.0 6838.2 6848.7 6759.4 6764.0 6777.2 6805.4 6827.1 6545.6 6657.8 6668.6 6685.8 6691.2 6838.6 6848.2 6856.7 6863.3 6870.2 6615.1 6627.7 6645.0 6679.5 6706.4 05:56:51 INFO - PROCESS | 9637 | 05:56:51 INFO - PROCESS | 9637 | [#5] yui.html Cycles:180 Average:13347.94 Median:47505.52 stddev:15234.88 (32.1%) stddev-sans-first:15248.59 05:56:51 INFO - PROCESS | 9637 | Values: 825.9 839.8 840.1 842.3 850.4 13181.3 13220.1 13291.5 13325.5 13326.2 11581.0 11584.1 11598.2 11608.5 11611.4 659.9 668.4 803.5 818.5 821.6 803.8 806.7 808.1 814.5 814.9 847.1 847.7 850.3 850.5 854.2 841.1 842.6 845.6 846.4 848.9 623.1 623.2 627.0 629.8 632.9 12536.9 12543.1 12556.2 12593.2 12695.4 12481.3 12629.7 12729.2 12769.9 12816.9 9784.0 10522.4 10633.8 10660.1 11003.7 3493.5 3532.8 3542.1 3650.0 3653.7 47579.3 47628.0 48360.0 48537.3 48672.8 9450.4 9742.0 9751.4 10040.2 10093.8 17447.6 17486.5 17495.5 17504.1 17593.2 7391.9 7446.7 7460.1 7460.7 7472.4 4015.7 4018.8 4083.4 4154.8 4204.1 2962.1 2998.2 3017.5 3020.6 3035.1 570.2 578.4 585.9 590.8 591.2 516.3 545.4 584.6 624.5 668.8 8144.7 8183.0 8323.8 9068.4 9122.6 516.5 520.1 543.6 629.9 683.8 3662.4 3754.0 3807.5 3827.9 3876.5 50959.2 51013.5 51402.2 51480.0 51513.0 49758.0 49887.3 50279.7 50771.7 50854.5 44920.0 45630.0 46737.3 47417.5 47431.8 8575.3 8789.5 8856.5 8961.4 8987.9 33703.8 33842.3 34611.7 34917.7 35096.0 38974.2 39331.4 41949.6 42069.0 42358.8 10851.3 10874.3 10894.8 10913.4 11085.1 11308.2 11313.4 11358.2 11648.7 11680.5 11227.6 11254.7 11354.3 11674.1 11724.2 11337.3 11566.5 11621.9 11943.6 11994.7 10420.9 10923.8 11024.0 11387.9 11421.2 9381.2 9411.7 9412.4 9534.8 9849.1 8764.2 9017.0 9120.3 9163.2 9661.2 05:56:51 INFO - PROCESS | 9637 | -------- Summary: end -------- 05:56:51 INFO - PROCESS | 9637 | 05:56:52 INFO - TEST-INFO | 9637: exit 0 05:56:52 INFO - TEST-OK | dromaeo_css | took 1111038ms 05:56:52 INFO - TEST-START | kraken 05:56:52 INFO - operating with platform_type : linux_ 05:56:52 INFO - Initialising browser for kraken test... 05:56:52 INFO - TEST-INFO | started process 9878 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGJ90d0/profile http://localhost:47920/getInfo.html) 05:56:55 INFO - PROCESS | 9878 | 05:56:55 INFO - PROCESS | 9878 | (process:9949): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:56:56 INFO - PROCESS | 9878 | __metrics Screen width/height:1600/1200 05:56:56 INFO - PROCESS | 9878 | colorDepth:24 05:56:56 INFO - PROCESS | 9878 | Browser inner width/height: 1024/697 05:56:56 INFO - PROCESS | 9878 | __metrics 05:56:56 INFO - PROCESS | 9878 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:56:57 INFO - TEST-INFO | 9878: exit 0 05:56:57 INFO - Browser initialized. 05:56:57 INFO - Running cycle 1/1 for kraken test... 05:56:57 INFO - TEST-INFO | started process 9998 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGJ90d0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:58 INFO - PROCESS | 9998 | 05:56:58 INFO - PROCESS | 9998 | (process:10058): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:57:09 INFO - PROCESS | 9998 | RSS: Main: 152215552 05:57:09 INFO - PROCESS | 9998 | 05:57:11 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47920/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:12 INFO - PROCESS | 9998 | RSS: Main: 155697152 05:57:12 INFO - PROCESS | 9998 | 05:57:15 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47920/tests/kraken/driver.html?testName=audio-dft) 05:57:15 INFO - PROCESS | 9998 | RSS: Main: 159543296 05:57:15 INFO - PROCESS | 9998 | 05:57:18 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47920/tests/kraken/driver.html?testName=audio-fft) 05:57:19 INFO - PROCESS | 9998 | RSS: Main: 153972736 05:57:19 INFO - PROCESS | 9998 | 05:57:21 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47920/tests/kraken/driver.html?testName=audio-oscillator) 05:57:21 INFO - PROCESS | 9998 | RSS: Main: 152236032 05:57:21 INFO - PROCESS | 9998 | 05:57:23 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47920/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:24 INFO - PROCESS | 9998 | RSS: Main: 153145344 05:57:24 INFO - PROCESS | 9998 | 05:57:27 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47920/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:28 INFO - PROCESS | 9998 | RSS: Main: 154681344 05:57:28 INFO - PROCESS | 9998 | 05:57:31 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47920/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:32 INFO - PROCESS | 9998 | RSS: Main: 154009600 05:57:32 INFO - PROCESS | 9998 | 05:57:34 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47920/tests/kraken/driver.html?testName=json-parse-financial) 05:57:35 INFO - PROCESS | 9998 | RSS: Main: 154218496 05:57:35 INFO - PROCESS | 9998 | 05:57:37 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47920/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:37 INFO - PROCESS | 9998 | RSS: Main: 155172864 05:57:37 INFO - PROCESS | 9998 | 05:57:39 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47920/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:40 INFO - PROCESS | 9998 | RSS: Main: 153952256 05:57:40 INFO - PROCESS | 9998 | 05:57:42 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47920/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:42 INFO - PROCESS | 9998 | RSS: Main: 154595328 05:57:42 INFO - PROCESS | 9998 | 05:57:45 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:45 INFO - PROCESS | 9998 | RSS: Main: 154230784 05:57:45 INFO - PROCESS | 9998 | 05:57:48 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:57:48 INFO - PROCESS | 9998 | RSS: Main: 154374144 05:57:48 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | Cycle 1(1): loaded http://localhost:47920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47920/tests/kraken/driver.html?testName=ai-astar) 05:57:50 INFO - PROCESS | 9998 | RSS: Main: 156024832 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | __start_tp_report 05:57:50 INFO - PROCESS | 9998 | _x_x_mozilla_page_load 05:57:50 INFO - PROCESS | 9998 | _x_x_mozilla_page_load_details 05:57:50 INFO - PROCESS | 9998 | |i|pagename|runs| 05:57:50 INFO - PROCESS | 9998 | |0;ai-astar;111;107;112;111;110;121;111;110;109;114 05:57:50 INFO - PROCESS | 9998 | |1;audio-beat-detection;148;135;153;167;126;156;157;127;170;133 05:57:50 INFO - PROCESS | 9998 | |2;audio-dft;162;161;162;162;168;161;162;168;170;161 05:57:50 INFO - PROCESS | 9998 | |3;audio-fft;73;76;76;75;74;138;73;76;74;75 05:57:50 INFO - PROCESS | 9998 | |4;audio-oscillator;97;97;150;96;97;97;151;96;96;150 05:57:50 INFO - PROCESS | 9998 | |5;imaging-gaussian-blur;109;109;110;110;110;110;110;110;109;110 05:57:50 INFO - PROCESS | 9998 | |6;imaging-darkroom;146;146;146;148;146;147;147;146;146;147 05:57:50 INFO - PROCESS | 9998 | |7;imaging-desaturate;96;96;101;96;97;99;101;96;95;97 05:57:50 INFO - PROCESS | 9998 | |8;json-parse-financial;60;59;60;61;60;60;62;61;71;58 05:57:50 INFO - PROCESS | 9998 | |9;json-stringify-tinderbox;66;67;69;67;67;67;67;67;67;68 05:57:50 INFO - PROCESS | 9998 | |10;stanford-crypto-aes;82;84;82;82;82;82;89;82;83;82 05:57:50 INFO - PROCESS | 9998 | |11;stanford-crypto-ccm;120;128;125;115;116;122;112;119;117;120 05:57:50 INFO - PROCESS | 9998 | |12;stanford-crypto-pbkdf2;138;142;151;141;139;138;138;138;153;139 05:57:50 INFO - PROCESS | 9998 | |13;stanford-crypto-sha256-iterative;66;66;66;65;67;74;66;69;64;65 05:57:50 INFO - PROCESS | 9998 | __end_tp_report 05:57:50 INFO - PROCESS | 9998 | __start_cc_report 05:57:50 INFO - PROCESS | 9998 | _x_x_mozilla_cycle_collect,750 05:57:50 INFO - PROCESS | 9998 | __end_cc_report 05:57:50 INFO - PROCESS | 9998 | __startTimestamp1453643870720__endTimestamp 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | ------- Summary: start ------- 05:57:50 INFO - PROCESS | 9998 | Number of tests: 14 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:3.78 (3.4%) stddev-sans-first:4.00 05:57:50 INFO - PROCESS | 9998 | Values: 111.0 107.0 112.0 111.0 110.0 121.0 111.0 110.0 109.0 114.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:154.50 stddev:16.08 (10.4%) stddev-sans-first:17.05 05:57:50 INFO - PROCESS | 9998 | Values: 148.0 135.0 153.0 167.0 126.0 156.0 157.0 127.0 170.0 133.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#2] audio-dft Cycles:10 Average:163.70 Median:162.00 stddev:3.50 (2.2%) stddev-sans-first:3.66 05:57:50 INFO - PROCESS | 9998 | Values: 162.0 161.0 162.0 162.0 168.0 161.0 162.0 168.0 170.0 161.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:20.06 (26.7%) stddev-sans-first:21.07 05:57:50 INFO - PROCESS | 9998 | Values: 73.0 76.0 76.0 75.0 74.0 138.0 73.0 76.0 74.0 75.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#4] audio-oscillator Cycles:10 Average:112.70 Median:96.50 stddev:25.97 (26.9%) stddev-sans-first:26.92 05:57:50 INFO - PROCESS | 9998 | Values: 97.0 97.0 150.0 96.0 97.0 97.0 151.0 96.0 96.0 150.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:57:50 INFO - PROCESS | 9998 | Values: 109.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 05:57:50 INFO - PROCESS | 9998 | Values: 146.0 146.0 146.0 148.0 146.0 147.0 147.0 146.0 146.0 147.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:96.00 stddev:2.17 (2.3%) stddev-sans-first:2.24 05:57:50 INFO - PROCESS | 9998 | Values: 96.0 96.0 101.0 96.0 97.0 99.0 101.0 96.0 95.0 97.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:60.50 stddev:3.61 (6.0%) stddev-sans-first:3.81 05:57:50 INFO - PROCESS | 9998 | Values: 60.0 59.0 60.0 61.0 60.0 60.0 62.0 61.0 71.0 58.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 05:57:50 INFO - PROCESS | 9998 | Values: 66.0 67.0 69.0 67.0 67.0 67.0 67.0 67.0 67.0 68.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:82.00 stddev:2.21 (2.7%) stddev-sans-first:2.32 05:57:50 INFO - PROCESS | 9998 | Values: 82.0 84.0 82.0 82.0 82.0 82.0 89.0 82.0 83.0 82.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:120.00 stddev:4.77 (4.0%) stddev-sans-first:5.05 05:57:50 INFO - PROCESS | 9998 | Values: 120.0 128.0 125.0 115.0 116.0 122.0 112.0 119.0 117.0 120.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:140.00 stddev:5.62 (4.0%) stddev-sans-first:5.80 05:57:50 INFO - PROCESS | 9998 | Values: 138.0 142.0 151.0 141.0 139.0 138.0 138.0 138.0 153.0 139.0 05:57:50 INFO - PROCESS | 9998 | 05:57:50 INFO - PROCESS | 9998 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.00 stddev:2.86 (4.3%) stddev-sans-first:3.02 05:57:50 INFO - PROCESS | 9998 | Values: 66.0 66.0 66.0 65.0 67.0 74.0 66.0 69.0 64.0 65.0 05:57:50 INFO - PROCESS | 9998 | -------- Summary: end -------- 05:57:50 INFO - PROCESS | 9998 | 05:57:51 INFO - TEST-INFO | 9998: exit 0 05:57:51 INFO - TEST-OK | kraken | took 59420ms 05:57:51 INFO - TEST-START | v8_7 05:57:51 INFO - operating with platform_type : linux_ 05:57:51 INFO - Initialising browser for v8_7 test... 05:57:51 INFO - TEST-INFO | started process 10286 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeLCCiY/profile http://localhost:47920/getInfo.html) 05:57:55 INFO - PROCESS | 10286 | 05:57:55 INFO - PROCESS | 10286 | (process:10356): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:57:56 INFO - PROCESS | 10286 | __metrics Screen width/height:1600/1200 05:57:56 INFO - PROCESS | 10286 | colorDepth:24 05:57:56 INFO - PROCESS | 10286 | Browser inner width/height: 1024/697 05:57:56 INFO - PROCESS | 10286 | __metrics 05:57:56 INFO - PROCESS | 10286 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:57:57 INFO - TEST-INFO | 10286: exit 0 05:57:57 INFO - Browser initialized. 05:57:57 INFO - Running cycle 1/1 for v8_7 test... 05:57:57 INFO - TEST-INFO | started process 10405 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeLCCiY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:58 INFO - PROCESS | 10405 | 05:57:58 INFO - PROCESS | 10405 | (process:10464): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:58:08 INFO - PROCESS | 10405 | RSS: Main: 150003712 05:58:08 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | Cycle 1(1): loaded http://localhost:47920/tests/v8_7/run.html (next: http://localhost:47920/tests/v8_7/run.html) 05:58:31 INFO - PROCESS | 10405 | RSS: Main: 150962176 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | __start_tp_report 05:58:31 INFO - PROCESS | 10405 | _x_x_mozilla_page_load 05:58:31 INFO - PROCESS | 10405 | _x_x_mozilla_page_load_details 05:58:31 INFO - PROCESS | 10405 | |i|pagename|runs| 05:58:31 INFO - PROCESS | 10405 | |0;Richards;166.55562958027983 05:58:31 INFO - PROCESS | 10405 | |1;DeltaBlue;189.000189000189 05:58:31 INFO - PROCESS | 10405 | |2;Encrypt;279.4857462269424 05:58:31 INFO - PROCESS | 10405 | |3;Decrypt;5240.837696335078 05:58:31 INFO - PROCESS | 10405 | |4;RayTrace;1091.703056768559 05:58:31 INFO - PROCESS | 10405 | |5;Earley;735.2941176470588 05:58:31 INFO - PROCESS | 10405 | |6;Boyer;12382.716049382716 05:58:31 INFO - PROCESS | 10405 | |7;RegExp;41220 05:58:31 INFO - PROCESS | 10405 | |8;Splay;555.1876379690949 05:58:31 INFO - PROCESS | 10405 | |9;NavierStokes;4835.748792270531 05:58:31 INFO - PROCESS | 10405 | __end_tp_report 05:58:31 INFO - PROCESS | 10405 | __startTimestamp1453643911739__endTimestamp 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | ------- Summary: start ------- 05:58:31 INFO - PROCESS | 10405 | Number of tests: 10 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 05:58:31 INFO - PROCESS | 10405 | Values: 166.6 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | [#1] DeltaBlue Cycles:1 Average:189.00 Median:189.00 stddev:0.00 (0.0%) 05:58:31 INFO - PROCESS | 10405 | Values: 189.0 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 05:58:31 INFO - PROCESS | 10405 | Values: 279.5 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 05:58:31 INFO - PROCESS | 10405 | Values: 5240.8 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | [#4] RayTrace Cycles:1 Average:1091.70 Median:1091.70 stddev:0.00 (0.0%) 05:58:31 INFO - PROCESS | 10405 | Values: 1091.7 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | [#5] Earley Cycles:1 Average:735.29 Median:735.29 stddev:0.00 (0.0%) 05:58:31 INFO - PROCESS | 10405 | Values: 735.3 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 05:58:31 INFO - PROCESS | 10405 | Values: 12382.7 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | [#7] RegExp Cycles:1 Average:41220.00 Median:41220.00 stddev:0.00 (0.0%) 05:58:31 INFO - PROCESS | 10405 | Values: 41220.0 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | [#8] Splay Cycles:1 Average:555.19 Median:555.19 stddev:0.00 (0.0%) 05:58:31 INFO - PROCESS | 10405 | Values: 555.2 05:58:31 INFO - PROCESS | 10405 | 05:58:31 INFO - PROCESS | 10405 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:58:31 INFO - PROCESS | 10405 | Values: 4835.7 05:58:31 INFO - PROCESS | 10405 | -------- Summary: end -------- 05:58:31 INFO - PROCESS | 10405 | 05:58:32 INFO - TEST-INFO | 10405: exit 0 05:58:32 INFO - TEST-OK | v8_7 | took 41051ms 05:58:32 INFO - SUITE-END | took 1211s 05:58:33 INFO - Completed test suite (00:20:12) 05:58:33 INFO - Working with test: dromaeo_css 05:58:33 INFO - Generating results file: dromaeo_css 05:58:33 INFO - Working with test: kraken 05:58:33 INFO - Generating results file: kraken 05:58:33 INFO - javascript benchmark 05:58:33 INFO - Working with test: v8_7 05:58:33 INFO - Generating results file: v8_7 05:58:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 05:58:33 INFO - process_Request line: dromaeo_css 6791.64 graph.html#tests=[[72,1,43]] 05:58:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:33 INFO - process_Request line: kraken 1509.10 graph.html#tests=[[232,1,43]] 05:58:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:33 INFO - process_Request line: v8_7 20397.61 graph.html#tests=[[230,1,43]] 05:58:33 INFO - RETURN: dromaeo_css: 6791.64 05:58:33 INFO - RETURN: kraken: 1509.10 05:58:33 INFO - RETURN: v8_7: 20397.61 05:58:33 INFO - javascript benchmark 05:58:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3138.7645926555506, 3152.9999999999986, 3188.2507610711464, 3196.6643502432235, 3218.0, 5158.123119069758, 5180.507851754087, 5218.008578370107, 5249.921251181236, 5266.052110620087, 5271.367435907697, 5291.576673866091, 5322.654027488211, 5379.435159308275, 5404.0, 4697.788599513022, 4738.147133515966, 4747.240441529356, 4823.927641085386, 4879.707217566957, 4583.220852455074, 4920.876978075559, 4927.088488629615, 4940.925886111693, 4993.051320249159, 4705.976470117662, 4803.423589169287, 4805.567498925078, 4852.02959408118, 4918.286848406979, 4701.717896926195, 4711.081339138869, 4716.268978308368, 4731.172044892164, 4741.834035808764, 4729.810807567727, 4767.451743049524, 4769.809207631691, 4801.783919723586, 4813.927791083137, 5110.28456016158, 5131.281620573122, 5147.047796157723, 5172.715500647463, 5176.767045482962, 5644.407337229614, 5672.744726487318, 5733.397993210695, 5815.331236907725, 5848.707564621752, 5733.541316694696, 5739.942600573982, 5741.598088133832, 5750.1949727038245, 5756.107803290455, 5378.811741589065, 5386.78452861885, 5389.892202155935, 5392.946070539284, 5395.514403703646, 5732.140178973187, 5732.140178973187, 5832.533397328203, 5902.970485147547, 5927.673977931169, 5504.449555044544, 5532.0, 5538.9169162462595, 5562.3881373048935, 5610.354809196994, 5581.74882130297, 5652.547796176296, 5656.8020119295625, 5661.575381846295, 5677.403872593318, 5435.0488664483555, 5507.504324610804, 5607.186957891165, 5632.324121105412, 5766.826995190151, 5530.5022547970875, 5539.723013849372, 5547.25112109868, 5582.665040097607, 5583.078791999355, 4329.480462344539, 4337.8264869404875, 4341.9565804341555, 4364.454443194601, 4378.496472905656, 3884.8251828667776, 3925.568187499373, 3960.6237407446247, 3973.2450834341385, 4009.8797036088963, 5380.461953804588, 5404.945950540444, 5409.648372855751, 5411.323584551931, 5479.561635069185, 5710.229119068873, 5770.711464426846, 5775.33583637887, 5786.942130578725, 5801.448862358069, 5222.3733152022005, 5374.516293533601, 5427.213054107132, 5450.754716037788, 5497.39528651848, 4723.055388922229, 4747.561746680504, 4764.0, 4780.4741478437345, 4811.350467686818, 5710.543156547466, 5739.426057394227, 5747.827565173052, 5852.063669812809, 5938.495227905676, 5730.484256416942, 5747.655140691572, 5763.423657634203, 5792.420757924174, 5831.387704291158, 5861.296644402699, 5901.675407852437, 5916.585838991229, 5918.437748413894, 5933.465988061095, 5539.362973258127, 5559.471850174227, 5579.553635709052, 5627.943720562742, 5691.089425692035, 5765.654060756368, 5788.189653448437, 5790.9286781945475, 5794.1308803679785, 5822.592418530662, 5623.353314368736, 5638.182463542681, 5655.2648155741135, 5669.489745922887, 5683.3748287687495, 5449.809256675997, 5539.750711217925, 5600.991821472174, 5623.718814059199, 5705.62913410627, 5340.385855626652, 5386.326709161355, 5405.0, 5415.377231618414, 5424.159255315432, 5445.428230035789, 5517.144842549411, 5531.280933478622, 5560.054790685674, 5596.944030559643, 5267.525922666979, 5340.759665815125, 5456.699881506555, 5536.335639723259, 5574.052411090205], "unit": "score", "name": "dojo.html", "value": 5233.7050409643}, {"lowerIsBetter": false, "replicates": [488.692123961904, 531.2058472583484, 533.2268211093915, 538.3244028743927, 554.6866020698304, 36157.819210903945, 36645.81677091617, 36755.448668269964, 36812.26375472489, 36898.0, 39358.0, 39928.0, 40041.799791001074, 40143.39784903221, 40337.798311008475, 8492.830143397145, 8566.614502347378, 8620.439671421369, 8654.913450865473, 8658.696945606906, 8360.498370097783, 8464.66141354345, 8481.0, 8732.301415886714, 8777.824443511126, 8655.091215422384, 8711.259542938858, 8795.780105497382, 8809.075047120055, 8817.074207208247, 8666.913330866673, 8746.606402711894, 8767.912320876805, 8774.912250877538, 8791.0, 8579.184977427134, 8648.437851539693, 8655.221030107321, 8695.826083478358, 8741.825163496758, 39614.801925990476, 40217.79891100526, 40353.596464035574, 40372.596274037474, 40382.79808600938, 2965.9258518536994, 3300.3069355435387, 3300.950485742716, 3369.1240277527772, 3645.6718895299286, 29361.0, 29797.553036704467, 30104.548431773543, 30628.38743225123, 31172.0, 3793.279276937373, 3848.615138486157, 3892.8832135035996, 3904.1996390739832, 3914.725969182158, 201318.0, 201398.9930050355, 201914.0, 202027.0, 202031.0, 51318.48681513212, 51629.741851290506, 57105.71447142821, 58674.70662646659, 59175.0, 52337.7383113082, 52511.474885251424, 52782.73608632009, 52790.47209527856, 53257.733711331195, 13875.861241387658, 13965.860341396456, 13992.30038498071, 14017.299135043411, 14128.152310861382, 10086.546105425274, 10091.344062635904, 10158.0, 10170.0, 10177.389356638625, 19043.047847607566, 19223.32718354851, 19266.133024013674, 19312.32406865781, 19431.514212144808, 7540.434467414966, 7868.803279918048, 7872.17342179063, 7918.287354138155, 7945.165757595485, 857.7298151082389, 866.7096522664851, 1037.1961729659574, 1084.983725244122, 1093.8186758301015, 28655.85672071668, 28739.56890646642, 29226.26934326616, 29381.85309073441, 29601.0, 1020.1379834040224, 1061.3843970497094, 1064.5050051725984, 1067.1676092647747, 1081.5025088459397, 13600.183988960496, 13903.79144312836, 14038.929805350908, 14982.550523484313, 15579.688406231811, 250547.0, 254767.0, 255146.0, 256234.0, 257458.0, 46839.531604683514, 46941.06117877623, 46987.765061174476, 47051.058978820234, 47125.764371177924, 1296.935153242353, 1309.6594885329882, 1326.2109045118139, 1343.7715588350004, 1346.1250187378087, 26113.0, 28650.713492864805, 29135.708642913298, 29166.708332916398, 30032.549511757778, 43419.34870976875, 43424.13151737011, 43601.78199108984, 43717.0, 43798.124037518435, 246995.0, 248068.0, 248890.0, 250156.0, 250432.0, 28916.566251505825, 31627.20931976627, 31815.0, 31982.0, 32393.514097288087, 37574.624253757116, 37578.43632345572, 38318.23363532658, 38423.0, 38582.80708596439, 34412.0, 34926.30147397089, 34934.82532587321, 35040.29919401547, 35119.12202194965, 34844.12889677778, 35224.29551409009, 35264.0, 35411.0, 35568.28863422665, 34341.141471463416, 35246.47130292996, 35337.64662353344, 35348.82325588356, 35443.46834797428, 31076.378472430875, 31189.0, 32048.359032818746, 32235.516467252542, 32359.35281294314, 24056.759432406154, 24460.75539244656, 24597.38506537351, 25258.989640414176, 27046.323841903322], "unit": "score", "name": "ext.html", "value": 17584.897814430795}, {"lowerIsBetter": false, "replicates": [364.3332701156885, 365.8609728303245, 366.48691831435985, 368.14773798656114, 373.143635356856, 16410.0, 16550.917245413755, 17186.398476053342, 17465.388711395102, 17901.910490447546, 11464.19750617457, 11832.585859494899, 16342.264598093085, 16351.754723679154, 16374.0, 4847.975760121194, 5369.24830523727, 5404.135338345865, 5429.4027656957705, 5432.533216031669, 5254.474552544734, 5428.4300148484435, 5453.836384908459, 5468.316460442445, 5494.1758736189695, 3693.076730817296, 3816.313063648542, 5446.7276636168235, 5447.591430642698, 5453.318335208099, 5341.4658534146665, 5490.917636235459, 5494.423085576017, 5523.6409633373705, 5533.612647114704, 5215.767158245898, 5336.866578335534, 5367.677939323653, 5395.622306438551, 5411.918821217685, 15155.772663410058, 19081.713774293257, 19644.90177549103, 19654.70517942232, 19765.703514447294, 2085.8748475091543, 2137.8824164670937, 2177.3250292409243, 2260.7287125544876, 2317.640765681322, 9166.541672916394, 9338.719838404859, 9348.252139828797, 9366.250699943988, 9515.524223788852, 1705.3690134650258, 1839.2826797548967, 1865.9253629854788, 1876.6340563590106, 1879.3891985104895, 55954.72022639901, 57012.42987570113, 58383.41616583865, 58446.0, 58501.707491462694, 10054.29619926598, 10069.647562335284, 10108.595656173671, 10125.443100629536, 10221.926697696636, 13237.602871913858, 13352.866471335163, 13374.13068150567, 13380.6654833628, 13415.530456434173, 7349.30181632744, 7351.8162045949275, 7393.260673932671, 7407.074115735533, 7441.702331906771, 6973.965130174418, 7011.859762804817, 7019.087518622547, 7051.717931282794, 7066.823329416806, 4371.103923695635, 4428.911421771611, 4455.688101832905, 4472.172648060119, 4478.104379124123, 1829.9542511437055, 1867.2530987605066, 1868.8504919606398, 1870.4108205915093, 1876.2119909637984, 421.5531536571183, 423.3501575082234, 446.187937952929, 826.2811354121952, 958.4441024205944, 10525.947370263253, 10996.725081873017, 11207.943960280147, 11216.551337946554, 11334.43327833605, 453.1458201290591, 473.75601565193955, 478.289739736491, 483.6735203737463, 486.46488862251243, 5848.152017957373, 6053.757849685963, 6113.6331820090045, 6129.938700613026, 6185.134081228632, 522240.0, 528098.0, 529506.0574091391, 546194.0, 559101.0, 62319.376806231354, 71386.0, 73565.0, 73831.63084184544, 73869.26130738624, 1095.8137116690182, 1117.474786850179, 1127.9323240605754, 1137.6928229378186, 1139.1911742662803, 14352.0, 14460.20468874222, 15152.545423637308, 15178.392864285746, 15262.007969481949, 28504.287392815346, 28857.0, 29510.852445737633, 30510.0, 30531.84734076404, 36685.26629467449, 36780.632193677724, 36801.26397471982, 36868.26263474662, 39343.80328098341, 4378.533191380923, 4588.908221835612, 7358.595277259802, 7465.514741541782, 7596.240375962359, 9645.662401815904, 10621.734456638645, 10748.570057197625, 11170.27393219438, 11662.650120496399, 9123.133302336268, 9261.583228754587, 9498.95250523743, 9711.0, 9767.316287859781, 9476.715698529055, 9655.565499552678, 9811.460369679737, 10031.197504199501, 10172.338797978107, 9088.863667045132, 9487.0, 9507.334486586149, 10212.897871021194, 10292.845607316047, 7401.814954625962, 7538.623068846646, 7557.584332861746, 7586.848263034598, 7598.658060387185, 8222.259996600334, 9985.0, 10021.09810117093, 10041.196704263788, 10092.89907100949], "unit": "score", "name": "jquery.html", "value": 7607.49506055642}, {"lowerIsBetter": false, "replicates": [1443.8556144385561, 1453.912765234086, 1584.6909852578751, 1706.6959604533888, 1734.3842935757805, 7512.136104348002, 7630.046244219473, 7651.923480765191, 7844.450888437812, 7852.803679907998, 7745.0, 7776.611169441534, 7786.338161256286, 7858.332041776442, 7859.528428294307, 2338.251759436981, 2370.0993622423457, 2373.347329484397, 2374.442006128558, 2376.4534157143867, 2371.632396978471, 2379.9643005354933, 2397.808175345977, 2416.516696660675, 2424.2969538833718, 2301.5972204864165, 2321.7213934327906, 2335.696359473266, 2406.0736616402637, 2420.782129608335, 2340.169239919821, 2356.917507887216, 2362.232274510782, 2379.6073647848084, 2389.2473870730664, 2378.607529757588, 2396.1493669747165, 2407.265783935899, 2414.8068154547595, 2415.4444477770035, 7557.47097703161, 7607.695692172307, 7614.657340419639, 7629.80925476862, 7656.310932016146, 4798.232282834764, 4871.82948596801, 4916.532929371704, 4916.778744956449, 4936.136176169192, 3133.1383869436086, 3166.667499912499, 3229.8546565404613, 3239.3683231769814, 3266.526353678727, 1054.3463052907246, 1073.2326386633595, 1077.8706555213346, 1096.2874131814306, 1118.4519585403093, 10787.514561844735, 10835.83746243807, 10895.891041089646, 10910.672679819618, 10956.397398143099, 4254.276772948606, 4394.582514661102, 4398.890027749268, 4458.71018383804, 4462.286034234507, 8750.781230469289, 8836.64653413869, 8855.955720221358, 8881.689140880038, 8895.555222238861, 4873.512648735098, 4908.9754551227015, 4910.091633047898, 4943.184374578154, 4971.726555039435, 4516.593506584423, 4526.637868970474, 4539.795709193094, 4583.197940360424, 4583.770811459413, 3581.8925432237074, 3628.5282913221113, 3645.0705070206927, 3651.233241019416, 3672.57765356982, 1063.7659714862718, 1124.2860783402598, 1141.4121727310442, 1142.8400023996646, 1149.5689116581282, 1092.3664274720643, 1105.3478447715886, 1136.9260998035102, 1276.234259444326, 1366.8223130992908, 7204.783856484209, 7251.057362542836, 7287.817804554928, 7295.52579082358, 7303.525270857377, 634.6572850660684, 636.1602684456566, 647.388218133859, 652.5008368598026, 783.9377643293369, 5722.456366645162, 5741.540676745851, 5813.418658134237, 5815.360310365856, 5846.181534585162, 8962.910370896338, 9105.2260557852, 9237.491937943343, 9288.11762882525, 9346.345755797029, 9190.724278271662, 9210.447373157633, 9236.353455258202, 9252.0, 9275.443473391619, 7213.567185968754, 7214.639268036683, 7219.0976127984, 7237.927620723725, 7291.0, 7215.314545118205, 7420.295071968154, 7426.071741032371, 7439.590822504814, 7448.553086814808, 8194.631241594261, 8267.049289331804, 8449.324054075782, 8524.27543658796, 8528.957355213184, 8508.149185081442, 8613.052564218056, 8742.781430464289, 8799.120087991405, 8819.470831749859, 6874.690638921161, 6911.896321555281, 6976.407005404598, 7016.473764467583, 7111.82220444493, 7526.32263096324, 7538.09542854861, 7554.131274903457, 7598.240175982358, 7611.923880761122, 6833.384995350442, 6858.588484690935, 7129.073220481304, 7187.1734750504365, 7188.101487314086, 6818.624975626388, 6832.077669514751, 6862.382385585322, 6872.347127022925, 6879.8992161253955, 7092.787216383516, 7098.893516597358, 7107.573545587281, 7120.038794762848, 7157.57054576727, 6661.766838160641, 6663.900041499284, 6697.397234248941, 6713.697883595152, 6724.361185687352, 6353.841153971188, 6486.318936511599, 6561.114249576246, 6564.179477565304, 6637.070810086495], "unit": "score", "name": "mootools.html", "value": 4497.402752850643}, {"lowerIsBetter": false, "replicates": [350.5477933465829, 350.5863081563755, 354.9325628130655, 356.4688613965192, 357.30147561517236, 6199.4110559496885, 6326.082718005887, 6348.619082855032, 6371.585846919953, 6422.710978005989, 6022.909656355158, 6242.656653884034, 6243.344448832864, 6294.464970477515, 6326.841828954267, 4823.903521929559, 4823.903521929559, 4827.51724827518, 4833.419989601252, 4847.733374664392, 4833.7099774013495, 4834.081524510332, 4838.661293709424, 4841.709497430148, 4842.515748425165, 4720.079584481027, 4801.951980480203, 4809.230523116302, 4810.687305325143, 4820.228763397857, 4775.307580400857, 4790.377250957388, 4793.233082706785, 4795.736234507101, 4806.807727690888, 4222.831086756526, 4229.851955181584, 4249.213895429355, 4252.2345977724, 4275.144971005811, 6009.819705408801, 6011.75952961881, 6023.518118550505, 6027.638341699512, 6060.090986352038, 5428.782848686048, 5596.468335508121, 5596.860078498029, 5602.047651899146, 5638.182463542805, 6618.437432818217, 6620.735170593171, 6631.104800851872, 6666.466682665424, 6682.565633233873, 4718.716876987358, 4719.315699223594, 4732.5977291929885, 4732.597729193023, 4737.313089601988, 6709.563878347892, 6940.201876784184, 6942.687579059005, 6969.337912898267, 6980.057692211537, 4669.322948172496, 4741.1465936131135, 4743.762811859393, 4745.810167593327, 4748.548887855648, 4753.928691069636, 4790.616750659939, 4798.2082956311815, 4807.567318941312, 4814.446338671028, 5577.3028371453565, 5577.386487486455, 5578.163275508706, 5593.0, 5596.412376700469, 6491.415772580396, 6606.141201643755, 6681.9331806682285, 6750.594964302158, 6781.152355955505, 1643.1866226218099, 1669.6410271791624, 1680.3362671744592, 1685.4522280258966, 1687.392538686072, 1111.0556027376665, 1121.2991880074953, 1122.063077330422, 1130.6070045881102, 1131.7170707323169, 6266.592671476339, 6295.622262664255, 6303.054541818764, 6338.778142764981, 6359.7456101755415, 6865.176178858469, 6871.622060786704, 6872.381485666314, 6874.484413668994, 6892.035115083892, 6149.846253843601, 6277.340879207709, 6281.089242059968, 6312.747490100436, 6347.904781428282, 3768.3028639701743, 3793.772373657534, 3804.1060350817534, 3805.353089974711, 3810.466534685146, 7235.38499227561, 7346.302101300368, 7346.33882950537, 7354.816129596696, 7366.189719130892, 6916.20463646677, 7105.182903966007, 7112.0754301940415, 7148.213696493382, 7151.7854464366155, 7295.963520182471, 7297.343239108506, 7303.671334789948, 7314.232005639437, 7319.15829679583, 6930.688119034555, 6950.79147625572, 6970.163580370388, 6971.65141742921, 6977.406920411619, 6734.9326506734305, 6866.485013623898, 6889.896651550131, 6893.138357705287, 6926.896096558455, 7231.855362892607, 7264.673089711081, 7314.597697126709, 7318.158411782713, 7322.1579518356075, 4706.670533062653, 4774.522547745198, 4796.472388037243, 4797.496262892346, 4802.183628783185, 6791.456683465212, 6878.449724021966, 6976.407005404598, 7032.296770322927, 7033.542819716702, 6757.560758550679, 6768.763093291711, 6820.045193672989, 6838.247792742894, 6848.7260509579055, 6759.391654751096, 6763.966180169067, 6777.152855893013, 6805.353491418307, 6827.146606674166, 6545.607263564201, 6657.833554160991, 6668.633225172662, 6685.799426017227, 6691.230508491391, 6838.589684618939, 6848.2124555674745, 6856.725730970706, 6863.2793556677825, 6870.20992585859, 6615.140031795836, 6627.701753421204, 6645.036469711961, 6679.4990375721045, 6706.362895524917], "unit": "score", "name": "prototype.html", "value": 5066.380934479548}, {"lowerIsBetter": false, "replicates": [825.925666689998, 839.7732612194703, 840.1010918317401, 842.321930845669, 850.4344610833796, 13181.34093295335, 13220.1406908551, 13291.534796282132, 13325.466981320747, 13326.200427974303, 11581.015613672827, 11584.131190160751, 11598.246114002584, 11608.535658573668, 11611.361375124365, 659.8548319369755, 668.4385116502137, 803.4656953126164, 818.4516374029415, 821.5850995247391, 803.7950322667712, 806.72168102005, 808.0989696488402, 814.4583851738587, 814.9103598604149, 847.1147650704997, 847.7287268074218, 850.3324889961382, 850.5152063323908, 854.1757204297851, 841.0622156295717, 842.5787106446777, 845.5983407881268, 846.3736834742308, 848.9108643592426, 623.0622912516678, 623.1587357067922, 626.9749210031594, 629.7795771479991, 632.8765890651325, 12536.874631253753, 12543.121981461301, 12556.246625202517, 12593.181443206162, 12695.428705708266, 12481.251124932442, 12629.684257893534, 12729.236245825281, 12769.87230127696, 12816.935915320457, 9783.951080244553, 10522.42126683032, 10633.840492392621, 10660.147188224923, 11003.669889903316, 3493.4759786032046, 3532.8056956867363, 3542.096765324826, 3649.9635003649887, 3653.6894363978827, 47579.28631070536, 47628.0, 48360.0, 48537.27194092092, 48672.75663621659, 9450.385724927995, 9742.0, 9751.430242818973, 10040.246981476419, 10093.848592271122, 17447.563810904576, 17486.47540573785, 17495.475135745946, 17504.12479376026, 17593.208305626278, 7391.926080739124, 7446.7021319146625, 7460.104787425544, 7460.738874139379, 7472.364848987788, 4015.658669013108, 4018.7588744675413, 4083.3670781028986, 4154.813033413504, 4204.096119334357, 2962.1113665900575, 2998.220462679719, 3017.5473678947897, 3020.562018507304, 3035.104644129987, 570.2273419516579, 578.3666884761179, 585.8857522783017, 590.8138936235072, 591.1723586978179, 516.3210378352454, 545.4463719324889, 584.6112335297065, 624.4816802054283, 668.8428219368444, 8144.674213031531, 8183.0, 8323.791905202419, 9068.410553314014, 9122.589483473259, 516.5012739042903, 520.1183993131606, 543.6086018066985, 629.8582818865718, 683.8256244657581, 3662.377395842713, 3753.962460375416, 3807.485989391452, 3827.936489022639, 3876.4960555127655, 50959.235611465854, 51013.48986510162, 51402.22896656553, 51480.0, 51513.0, 49758.0, 49887.25169122466, 50279.74860125676, 50771.746141269796, 50854.49145508498, 44920.0, 45630.0, 46737.29894051592, 47417.525824742, 47431.762841184885, 8575.31397488187, 8789.516576588348, 8856.468611883307, 8961.417507861968, 8987.910120898707, 33703.79813917674, 33842.32315353728, 34611.653883460844, 34917.650823491436, 35096.0, 38974.22051558896, 39331.410028850165, 41949.580504194564, 42069.0, 42358.78820605877, 10851.348919064882, 10874.347539147677, 10894.836577451502, 10913.40568557571, 11085.113190944543, 11308.151888608223, 11313.377764223047, 11358.204925655125, 11648.708782280512, 11680.532778689098, 11227.607033753779, 11254.662360129209, 11354.318740875575, 11674.066074714172, 11724.179307448738, 11337.26307789991, 11566.537338506365, 11621.88378116208, 11943.641690749291, 11994.700132496408, 10420.947895260475, 10923.836142458029, 11024.0, 11387.889688249203, 11421.200515964136, 9381.233543445174, 9411.670591529264, 9412.388194767318, 9534.761630959281, 9849.113579777855, 8764.21122099014, 9017.0, 9120.315976301936, 9163.175314221751, 9661.227101831977], "unit": "score", "name": "yui.html", "value": 6151.224839306742}], "name": "dromaeo_css", "value": 6791.634845674752}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 112.0, 111.0, 110.0, 121.0, 111.0, 110.0, 109.0, 114.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [148.0, 135.0, 153.0, 167.0, 126.0, 156.0, 157.0, 127.0, 170.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 162.0, 168.0, 161.0, 162.0, 168.0, 170.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 76.0, 75.0, 74.0, 138.0, 73.0, 76.0, 74.0, 75.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 150.0, 96.0, 97.0, 97.0, 151.0, 96.0, 96.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 112.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 148.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 101.0, 96.0, 97.0, 99.0, 101.0, 96.0, 95.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.4}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 60.0, 61.0, 60.0, 60.0, 62.0, 61.0, 71.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 61.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 82.0, 82.0, 82.0, 82.0, 89.0, 82.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [120.0, 128.0, 125.0, 115.0, 116.0, 122.0, 112.0, 119.0, 117.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [138.0, 142.0, 151.0, 141.0, 139.0, 138.0, 138.0, 138.0, 153.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 74.0, 66.0, 69.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1509.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [189.000189000189], "unit": "score", "name": "DeltaBlue", "value": 349.8303379999999}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1091.703056768559], "unit": "score", "name": "RayTrace", "value": 677.8299240000001}, {"lowerIsBetter": false, "replicates": [735.2941176470588], "unit": "score", "name": "Earley", "value": 906.3896799999999}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [41220.0], "unit": "score", "name": "RegExp", "value": 22.10055798156234}, {"lowerIsBetter": false, "replicates": [555.1876379690949], "unit": "score", "name": "Splay", "value": 146.78100596421473}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20397.61200994991}]} 05:58:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20397.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1509.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6791.64"}}} 05:58:33 INFO - Return code: 0 05:58:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:58:33 INFO - # TBPL SUCCESS # 05:58:33 INFO - Running post-action listener: _resource_record_post_action 05:58:33 INFO - Running post-run listener: _resource_record_post_run 05:58:34 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 143360; Write bytes: 551227392; Read time: 24; Write time: 504636 05:58:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236449792; Read time: 0; Write time: 249432 05:58:34 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 143360; Write bytes: 314777600; Read time: 24; Write time: 255204 05:58:34 INFO - Running post-run listener: _upload_blobber_files 05:58:34 INFO - Blob upload gear active. 05:58:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:58:34 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 05:58:34 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'] 05:58:34 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 05:58:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:58:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:58:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:35 INFO - (blobuploader) - INFO - Done attempting. 05:58:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:58:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:58:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:36 INFO - (blobuploader) - INFO - Done attempting. 05:58:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:36 INFO - Return code: 0 05:58:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:58:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3984458666f99d9494f4d5b0f105dd9d2964bf638958d3be76fffc907e78d8bb679fa1bbfc4e226e676b827f8fd7dca3e407e2cbab9c0297d2791d79bb836ceb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/141f4898fb82512bb06ed535ba557cb425ce752fe653247f37258641f50b469e6a86d8f1944b47e974b4418d7d1532a03e1edd06d12ecf360f6e291f90458779"} 05:58:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:58:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:58:36 INFO - Contents: 05:58:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3984458666f99d9494f4d5b0f105dd9d2964bf638958d3be76fffc907e78d8bb679fa1bbfc4e226e676b827f8fd7dca3e407e2cbab9c0297d2791d79bb836ceb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/141f4898fb82512bb06ed535ba557cb425ce752fe653247f37258641f50b469e6a86d8f1944b47e974b4418d7d1532a03e1edd06d12ecf360f6e291f90458779"} 05:58:36 INFO - Running post-run listener: copy_logs_to_upload_dir 05:58:36 INFO - Copying logs to upload dir... 05:58:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:58:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.505940 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-24 05:58:36.295048) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 05:58:36.298910) ========= 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=836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698 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/3984458666f99d9494f4d5b0f105dd9d2964bf638958d3be76fffc907e78d8bb679fa1bbfc4e226e676b827f8fd7dca3e407e2cbab9c0297d2791d79bb836ceb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/141f4898fb82512bb06ed535ba557cb425ce752fe653247f37258641f50b469e6a86d8f1944b47e974b4418d7d1532a03e1edd06d12ecf360f6e291f90458779"} build_url:https://queue.taskcluster.net/v1/task/JqfwjRB1TV-UfdqWeHVnFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/JqfwjRB1TV-UfdqWeHVnFg/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/3984458666f99d9494f4d5b0f105dd9d2964bf638958d3be76fffc907e78d8bb679fa1bbfc4e226e676b827f8fd7dca3e407e2cbab9c0297d2791d79bb836ceb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/141f4898fb82512bb06ed535ba557cb425ce752fe653247f37258641f50b469e6a86d8f1944b47e974b4418d7d1532a03e1edd06d12ecf360f6e291f90458779"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 05:58:36.324819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 05:58:36.325224) ========= 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=836cfdc75598d54cb747368e000001a9-1453638076.284402-1237816698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 05:58:36.408653) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 05:58:36.409015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 05:58:36.409409) ========= ========= Total master_lag: 0.36 =========