builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1453740157.13 results: success (0) buildid: 20160125030203 builduid: fa9411aaf741499a9b7142874c71568d revision: 67c66c2878aed17ae3096d7db483ddbb2293c503 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.127805) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.128875) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.129232) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006211 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.152032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.152370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.169140) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.169480) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012333 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.218981) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.219284) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.219656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.219950) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 08:42:37-- 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% 83.6M=0s 2016-01-25 08:42:37 (83.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165313 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.398034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.398345) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.095943 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:37.505828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 08:42:37.506248) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 67c66c2878aed17ae3096d7db483ddbb2293c503 --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 67c66c2878aed17ae3096d7db483ddbb2293c503 --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=fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 08:42:37,608 truncating revision to first 12 chars 2016-01-25 08:42:37,608 Setting DEBUG logging. 2016-01-25 08:42:37,608 attempt 1/10 2016-01-25 08:42:37,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/67c66c2878ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 08:42:38,066 unpacking tar archive at: mozilla-central-67c66c2878ae/testing/mozharness/ program finished with exit code 0 elapsedTime=1.088800 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 08:42:38.626380) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:38.626799) ========= echo 67c66c2878aed17ae3096d7db483ddbb2293c503 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'67c66c2878aed17ae3096d7db483ddbb2293c503'] 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=fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 67c66c2878aed17ae3096d7db483ddbb2293c503 program finished with exit code 0 elapsedTime=0.003781 script_repo_revision: '67c66c2878aed17ae3096d7db483ddbb2293c503' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:38.675360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:38.675684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 08:42:38.685684) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-25 08:42:38.685961) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:38 INFO - MultiFileLogger online at 20160125 08:42:38 in /builds/slave/test-pgo 08:42:38 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 08:42:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:42:38 INFO - {'append_to_log': False, 08:42:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:42:38 INFO - 'blob_upload_branch': 'Firefox', 08:42:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:42:38 INFO - 'branch': 'Firefox', 08:42:38 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:38 INFO - 'config_files': ('talos/linux_config.py',), 08:42:38 INFO - 'default_actions': ('clobber', 08:42:38 INFO - 'read-buildbot-config', 08:42:38 INFO - 'download-and-extract', 08:42:38 INFO - 'populate-webroot', 08:42:38 INFO - 'create-virtualenv', 08:42:38 INFO - 'install', 08:42:38 INFO - 'run-tests'), 08:42:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:38 INFO - 'download_minidump_stackwalk': True, 08:42:38 INFO - 'download_symbols': 'ondemand', 08:42:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:38 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:38 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:38 INFO - 'installer_path': 'installer.exe', 08:42:38 INFO - 'log_level': 'info', 08:42:38 INFO - 'log_name': 'talos', 08:42:38 INFO - 'log_to_console': True, 08:42:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:38 INFO - 'opt_config_files': (), 08:42:38 INFO - 'pip_index': False, 08:42:38 INFO - 'sps_profile': False, 08:42:38 INFO - 'sps_profile_interval': 0, 08:42:38 INFO - 'suite': 'dromaeojs-e10s', 08:42:38 INFO - 'system_bits': '32', 08:42:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:38 INFO - 'title': 'talos-linux64-ix-014', 08:42:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:38 INFO - 'use_talos_json': True, 08:42:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:42:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:38 INFO - 'work_dir': 'build'} 08:42:38 INFO - ##### 08:42:38 INFO - ##### Running clobber step. 08:42:38 INFO - ##### 08:42:38 INFO - Running pre-action listener: _resource_record_pre_action 08:42:38 INFO - Running main action method: clobber 08:42:38 INFO - rmtree: /builds/slave/test-pgo/build 08:42:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:42:44 INFO - Running post-action listener: _resource_record_post_action 08:42:44 INFO - ##### 08:42:44 INFO - ##### Running read-buildbot-config step. 08:42:44 INFO - ##### 08:42:44 INFO - Running pre-action listener: _resource_record_pre_action 08:42:44 INFO - Running main action method: read_buildbot_config 08:42:44 INFO - Using buildbot properties: 08:42:44 INFO - { 08:42:44 INFO - "project": "", 08:42:44 INFO - "product": "firefox", 08:42:44 INFO - "script_repo_revision": "production", 08:42:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:42:44 INFO - "repository": "", 08:42:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 08:42:44 INFO - "buildid": "20160125030203", 08:42:44 INFO - "stage_platform": "linux64-pgo", 08:42:44 INFO - "basedir": "/builds/slave/test-pgo", 08:42:44 INFO - "nightly_build": "True", 08:42:44 INFO - "buildnumber": 323, 08:42:44 INFO - "slavename": "talos-linux64-ix-014", 08:42:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:42:44 INFO - "platform": "ubuntu64_hw", 08:42:44 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 08:42:44 INFO - "branch": "mozilla-central", 08:42:44 INFO - "repo_path": "mozilla-central", 08:42:44 INFO - "revision": "67c66c2878aed17ae3096d7db483ddbb2293c503", 08:42:44 INFO - "pgo_build": "True", 08:42:44 INFO - "builduid": "fa9411aaf741499a9b7142874c71568d", 08:42:44 INFO - "slavebuilddir": "test" 08:42:44 INFO - } 08:42:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:42:44 INFO - Running post-action listener: _resource_record_post_action 08:42:44 INFO - ##### 08:42:44 INFO - ##### Running download-and-extract step. 08:42:44 INFO - ##### 08:42:44 INFO - Running pre-action listener: _resource_record_pre_action 08:42:44 INFO - Running main action method: download_and_extract 08:42:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:44 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:42:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json 08:42:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json 08:42:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:42:44 INFO - Downloaded 1448 bytes. 08:42:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:42:44 INFO - Using the following test package requirements: 08:42:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:42:44 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:42:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:44 INFO - u'jsshell-linux-x86_64.zip'], 08:42:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:42:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:42:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:42:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:42:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:42:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:44 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:42:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:42:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:42:45 INFO - Downloaded 22494448 bytes. 08:42:45 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'] 08:42:45 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 08:42:47 INFO - Return code: 0 08:42:47 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 08:42: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')]} 08:42:47 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:42:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:42:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:42:48 INFO - Downloaded 22494448 bytes. 08:42:48 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'] 08:42:48 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 08:42:49 INFO - Return code: 0 08:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:49 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:42:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:42:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:42:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:42:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:42:50 INFO - Downloaded 10706572 bytes. 08:42:50 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'] 08:42:50 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 08:42:50 INFO - Return code: 0 08:42: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')]} 08:42:50 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:42:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:42:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:42:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:42:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:42:52 INFO - Downloaded 55990395 bytes. 08:42:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:42:52 INFO - mkdir: /builds/slave/test-pgo/properties 08:42:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:42:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:42:52 INFO - Contents: 08:42:52 INFO - build_url:https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:42:52 INFO - Running post-action listener: _resource_record_post_action 08:42:52 INFO - Running post-action listener: set_extra_try_arguments 08:42:52 INFO - ##### 08:42:52 INFO - ##### Running populate-webroot step. 08:42:52 INFO - ##### 08:42:52 INFO - Running pre-action listener: _resource_record_pre_action 08:42:52 INFO - Running main action method: populate_webroot 08:42:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:52 INFO - '--tppagecycles', 08:42:52 INFO - '7'], 08:42:52 INFO - 'tests': ['tsvgm']}}, 08:42:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:42:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:42:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:42:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:42:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:42:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:52 INFO - 'talos_options': ['--e10s'], 08:42:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:52 INFO - 'tests': ['damp', 'tps']}, 08:42:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:52 INFO - 'talos_options': ['--e10s'], 08:42:52 INFO - 'tests': ['damp', 'tps']}, 08:42:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:42:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:52 INFO - 'other': {'tests': ['a11yr', 08:42:52 INFO - 'ts_paint', 08:42:52 INFO - 'tpaint', 08:42:52 INFO - 'sessionrestore', 08:42:52 INFO - 'sessionrestore_no_auto_restore']}, 08:42:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:42:52 INFO - 'tests': ['a11yr', 08:42:52 INFO - 'ts_paint', 08:42:52 INFO - 'tpaint', 08:42:52 INFO - 'sessionrestore', 08:42:52 INFO - 'sessionrestore_no_auto_restore']}, 08:42:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:42:52 INFO - 'tests': ['a11yr', 08:42:52 INFO - 'ts_paint', 08:42:52 INFO - 'tpaint', 08:42:52 INFO - 'sessionrestore', 08:42:52 INFO - 'sessionrestore_no_auto_restore']}, 08:42:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:42:52 INFO - 'tests': ['a11yr', 08:42:52 INFO - 'ts_paint', 08:42:52 INFO - 'tpaint', 08:42:52 INFO - 'sessionrestore', 08:42:52 INFO - 'sessionrestore_no_auto_restore']}, 08:42:52 INFO - 'other_l64': {'tests': ['a11yr', 08:42:52 INFO - 'ts_paint', 08:42:52 INFO - 'tpaint', 08:42:52 INFO - 'sessionrestore', 08:42:52 INFO - 'sessionrestore_no_auto_restore']}, 08:42:52 INFO - 'other_nol64': {'tests': ['a11yr', 08:42:52 INFO - 'ts_paint', 08:42:52 INFO - 'tpaint', 08:42:52 INFO - 'sessionrestore', 08:42:52 INFO - 'sessionrestore_no_auto_restore']}, 08:42:52 INFO - 'svgr': {'tests': ['tsvgx', 08:42:52 INFO - 'tsvgr_opacity', 08:42:52 INFO - 'tart', 08:42:52 INFO - 'tscrollx', 08:42:52 INFO - 'cart']}, 08:42:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:42:52 INFO - 'tests': ['tsvgx', 08:42:52 INFO - 'tsvgr_opacity', 08:42:52 INFO - 'tart', 08:42:52 INFO - 'tscrollx', 08:42:52 INFO - 'cart']}, 08:42:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:52 INFO - 'tests': ['tp5o']}, 08:42:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:52 INFO - 'talos_options': ['--e10s'], 08:42:52 INFO - 'tests': ['tp5o']}, 08:42:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:52 INFO - 'talos_options': ['--xperf_path', 08:42:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:52 INFO - 'tests': ['tp5n']}, 08:42:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:52 INFO - 'talos_options': ['--e10s', 08:42:52 INFO - '--xperf_path', 08:42:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:52 INFO - 'tests': ['tp5n']}}, 08:42:52 INFO - 'talos.zip': {'path': '', 08:42:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:52 INFO - Running post-action listener: _resource_record_post_action 08:42:52 INFO - ##### 08:42:52 INFO - ##### Running create-virtualenv step. 08:42:52 INFO - ##### 08:42:52 INFO - Running pre-action listener: _resource_record_pre_action 08:42:52 INFO - Running main action method: create_virtualenv 08:42:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:42:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 08:42:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:42:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:52 INFO - Using real prefix '/usr' 08:42:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:42:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:54 INFO - Installing pip.................done. 08:42:54 INFO - Return code: 0 08:42:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:42: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')]} 08:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:54 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 0x7f5d8b318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c540>, '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 0x2a3d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', '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 08:42:54 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 08:42:54 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 08:42:54 INFO - Using env: {'DISPLAY': ':0', 08:42:54 INFO - 'HOME': '/home/cltbld', 08:42:54 INFO - 'LANG': 'en_US.UTF-8', 08:42:54 INFO - 'LANGUAGE': 'en_US:en', 08:42:54 INFO - 'LOGNAME': 'cltbld', 08:42:54 INFO - 'MAIL': '/var/mail/cltbld', 08:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:54 INFO - 'MOZ_NO_REMOTE': '1', 08:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:54 INFO - 'NO_EM_RESTART': '1', 08:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:42:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:42:54 INFO - 'SHELL': '/bin/bash', 08:42:54 INFO - 'SHLVL': '1', 08:42:54 INFO - 'TERM': 'linux', 08:42:54 INFO - 'TMOUT': '86400', 08:42:54 INFO - 'USER': 'cltbld', 08:42:54 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', 08:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:54 INFO - '_': '/tools/buildbot/bin/python'} 08:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:54 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 08:42:54 INFO - Cleaning up... 08:42:54 INFO - Return code: 0 08:42:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:42: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')]} 08:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:54 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 0x7f5d8b318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c540>, '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 0x2a3d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', '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 08:42:54 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 08:42:54 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 08:42:54 INFO - Using env: {'DISPLAY': ':0', 08:42:54 INFO - 'HOME': '/home/cltbld', 08:42:54 INFO - 'LANG': 'en_US.UTF-8', 08:42:54 INFO - 'LANGUAGE': 'en_US:en', 08:42:54 INFO - 'LOGNAME': 'cltbld', 08:42:54 INFO - 'MAIL': '/var/mail/cltbld', 08:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:54 INFO - 'MOZ_NO_REMOTE': '1', 08:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:54 INFO - 'NO_EM_RESTART': '1', 08:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:42:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:42:54 INFO - 'SHELL': '/bin/bash', 08:42:54 INFO - 'SHLVL': '1', 08:42:54 INFO - 'TERM': 'linux', 08:42:54 INFO - 'TMOUT': '86400', 08:42:54 INFO - 'USER': 'cltbld', 08:42:54 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', 08:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:54 INFO - '_': '/tools/buildbot/bin/python'} 08:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:55 INFO - Downloading/unpacking psutil>=0.7.1 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:56 INFO - Installing collected packages: psutil 08:42:56 INFO - Running setup.py install for psutil 08:42:56 INFO - building 'psutil._psutil_linux' extension 08:42:56 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 08:42:57 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 08:42:57 INFO - building 'psutil._psutil_posix' extension 08:42:57 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 08:42:57 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 08:42:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:57 INFO - Successfully installed psutil 08:42:57 INFO - Cleaning up... 08:42:57 INFO - Return code: 0 08:42:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:42: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')]} 08:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:57 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 0x7f5d8b318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c540>, '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 0x2a3d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', '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 08:42:57 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 08:42:57 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 08:42:57 INFO - Using env: {'DISPLAY': ':0', 08:42:57 INFO - 'HOME': '/home/cltbld', 08:42:57 INFO - 'LANG': 'en_US.UTF-8', 08:42:57 INFO - 'LANGUAGE': 'en_US:en', 08:42:57 INFO - 'LOGNAME': 'cltbld', 08:42:57 INFO - 'MAIL': '/var/mail/cltbld', 08:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:57 INFO - 'MOZ_NO_REMOTE': '1', 08:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:57 INFO - 'NO_EM_RESTART': '1', 08:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:42:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:42:57 INFO - 'SHELL': '/bin/bash', 08:42:57 INFO - 'SHLVL': '1', 08:42:57 INFO - 'TERM': 'linux', 08:42:57 INFO - 'TMOUT': '86400', 08:42:57 INFO - 'USER': 'cltbld', 08:42:57 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', 08:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:57 INFO - '_': '/tools/buildbot/bin/python'} 08:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:42:57 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 08:42:57 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 08:42:57 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 08:42:57 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 08:42:57 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 08:42:57 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 08:42:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:42:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:42:59 INFO - Installing collected packages: mozsystemmonitor 08:42:59 INFO - Running setup.py install for mozsystemmonitor 08:42:59 INFO - Successfully installed mozsystemmonitor 08:42:59 INFO - Cleaning up... 08:42:59 INFO - Return code: 0 08:42:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5d8b318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c540>, '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 0x2a3d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', '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 08:42:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:42:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:42:59 INFO - Using env: {'DISPLAY': ':0', 08:42:59 INFO - 'HOME': '/home/cltbld', 08:42:59 INFO - 'LANG': 'en_US.UTF-8', 08:42:59 INFO - 'LANGUAGE': 'en_US:en', 08:42:59 INFO - 'LOGNAME': 'cltbld', 08:42:59 INFO - 'MAIL': '/var/mail/cltbld', 08:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:59 INFO - 'MOZ_NO_REMOTE': '1', 08:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:59 INFO - 'NO_EM_RESTART': '1', 08:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:42:59 INFO - 'PWD': '/builds/slave/test-pgo', 08:42:59 INFO - 'SHELL': '/bin/bash', 08:42:59 INFO - 'SHLVL': '1', 08:42:59 INFO - 'TERM': 'linux', 08:42:59 INFO - 'TMOUT': '86400', 08:42:59 INFO - 'USER': 'cltbld', 08:42:59 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', 08:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:59 INFO - '_': '/tools/buildbot/bin/python'} 08:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:59 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:01 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:43:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:02 INFO - Downloading docopt-0.6.1.tar.gz 08:43:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:02 INFO - Running setup.py install for blobuploader 08:43:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:43:02 INFO - Running setup.py install for requests 08:43:02 INFO - Running setup.py install for docopt 08:43:02 INFO - Successfully installed blobuploader requests docopt 08:43:02 INFO - Cleaning up... 08:43:02 INFO - Return code: 0 08:43:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:43:02 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')]} 08:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:02 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')]} 08:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:02 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 0x7f5d8b318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c540>, '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 0x2a3d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', '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 08:43:02 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 08:43:02 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 08:43:02 INFO - Using env: {'DISPLAY': ':0', 08:43:02 INFO - 'HOME': '/home/cltbld', 08:43:02 INFO - 'LANG': 'en_US.UTF-8', 08:43:02 INFO - 'LANGUAGE': 'en_US:en', 08:43:02 INFO - 'LOGNAME': 'cltbld', 08:43:02 INFO - 'MAIL': '/var/mail/cltbld', 08:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:02 INFO - 'MOZ_NO_REMOTE': '1', 08:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:02 INFO - 'NO_EM_RESTART': '1', 08:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:43:02 INFO - 'PWD': '/builds/slave/test-pgo', 08:43:02 INFO - 'SHELL': '/bin/bash', 08:43:02 INFO - 'SHLVL': '1', 08:43:02 INFO - 'TERM': 'linux', 08:43:02 INFO - 'TMOUT': '86400', 08:43:02 INFO - 'USER': 'cltbld', 08:43:02 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', 08:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:02 INFO - '_': '/tools/buildbot/bin/python'} 08:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:43:03 INFO - Running setup.py (path:/tmp/pip-q6KKzX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:43:03 INFO - Running setup.py (path:/tmp/pip-KzZGPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:43:03 INFO - Running setup.py (path:/tmp/pip-17_8Az-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:43:03 INFO - Running setup.py (path:/tmp/pip-p84In1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:43:03 INFO - Running setup.py (path:/tmp/pip-3vQBmF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:43:03 INFO - Running setup.py (path:/tmp/pip-p8oOIC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:43:03 INFO - Running setup.py (path:/tmp/pip-Pw2QQA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:43:03 INFO - Running setup.py (path:/tmp/pip-ILoBN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:43:03 INFO - Running setup.py (path:/tmp/pip-a21WPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:43:03 INFO - Running setup.py (path:/tmp/pip-mTSoCO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:43:03 INFO - Running setup.py (path:/tmp/pip-l4nWOf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:43:03 INFO - Running setup.py (path:/tmp/pip-d08b2t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:43:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:43:03 INFO - Running setup.py (path:/tmp/pip-qlPKP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:43:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:43:04 INFO - Running setup.py (path:/tmp/pip-G_vaOP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:43:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:43:04 INFO - Running setup.py (path:/tmp/pip-HIo2aD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:43:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:43:04 INFO - Running setup.py (path:/tmp/pip-pu9fi_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:43:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:43:04 INFO - Running setup.py (path:/tmp/pip-JCLMey-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:43:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:04 INFO - Running setup.py install for manifestparser 08:43:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:43:04 INFO - Running setup.py install for mozcrash 08:43:04 INFO - Running setup.py install for mozdebug 08:43:04 INFO - Running setup.py install for mozdevice 08:43:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:43:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:43:04 INFO - Running setup.py install for mozfile 08:43:04 INFO - Running setup.py install for mozhttpd 08:43:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:43:04 INFO - Running setup.py install for mozinfo 08:43:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Running setup.py install for mozInstall 08:43:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Running setup.py install for mozleak 08:43:05 INFO - Running setup.py install for mozlog 08:43:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Running setup.py install for moznetwork 08:43:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Running setup.py install for mozprocess 08:43:05 INFO - Running setup.py install for mozprofile 08:43:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Running setup.py install for mozrunner 08:43:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:43:05 INFO - Running setup.py install for mozscreenshot 08:43:05 INFO - Running setup.py install for moztest 08:43:05 INFO - Running setup.py install for mozversion 08:43:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:43:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:06 INFO - Cleaning up... 08:43:06 INFO - Return code: 0 08:43:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:43:06 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')]} 08:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:06 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')]} 08:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:06 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 0x7f5d8b318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c540>, '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 0x2a3d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', '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 08:43:06 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 08:43:06 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 08:43:06 INFO - Using env: {'DISPLAY': ':0', 08:43:06 INFO - 'HOME': '/home/cltbld', 08:43:06 INFO - 'LANG': 'en_US.UTF-8', 08:43:06 INFO - 'LANGUAGE': 'en_US:en', 08:43:06 INFO - 'LOGNAME': 'cltbld', 08:43:06 INFO - 'MAIL': '/var/mail/cltbld', 08:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:06 INFO - 'MOZ_NO_REMOTE': '1', 08:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:06 INFO - 'NO_EM_RESTART': '1', 08:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:43:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:43:06 INFO - 'SHELL': '/bin/bash', 08:43:06 INFO - 'SHLVL': '1', 08:43:06 INFO - 'TERM': 'linux', 08:43:06 INFO - 'TMOUT': '86400', 08:43:06 INFO - 'USER': 'cltbld', 08:43:06 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', 08:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:06 INFO - '_': '/tools/buildbot/bin/python'} 08:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:43:06 INFO - Running setup.py (path:/tmp/pip-HRKlLZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:43:06 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)) 08:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:43:06 INFO - Running setup.py (path:/tmp/pip-Xjaf0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:43:06 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)) 08:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:43:06 INFO - Running setup.py (path:/tmp/pip-3Ly8GX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:43:06 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)) 08:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:43:06 INFO - Running setup.py (path:/tmp/pip-wHTopa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:43:06 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)) 08:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:43:06 INFO - Running setup.py (path:/tmp/pip-qfB9Il-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:43:06 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)) 08:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:43:06 INFO - Running setup.py (path:/tmp/pip-DVpwDs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:43:06 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)) 08:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:43:06 INFO - Running setup.py (path:/tmp/pip-c32EDf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:43:06 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)) 08:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:43:06 INFO - Running setup.py (path:/tmp/pip-hoxi_2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:43:06 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)) 08:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:43:06 INFO - Running setup.py (path:/tmp/pip-za4eMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:43:07 INFO - Running setup.py (path:/tmp/pip-rcAbjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:43:07 INFO - Running setup.py (path:/tmp/pip-QXfPMj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:43:07 INFO - Running setup.py (path:/tmp/pip-4gnCGz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:43:07 INFO - Running setup.py (path:/tmp/pip-SDgyZP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:43:07 INFO - Running setup.py (path:/tmp/pip-pCJI5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:43:07 INFO - Running setup.py (path:/tmp/pip-gZSO76-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:43:07 INFO - Running setup.py (path:/tmp/pip-HZZNlQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:43:07 INFO - Running setup.py (path:/tmp/pip-CfAg9S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:43:07 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)) 08:43:07 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)) 08:43:07 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)) 08:43:07 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)) 08:43:07 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)) 08:43:07 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)) 08:43:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:07 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 08:43:07 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 08:43:07 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 08:43:07 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 08:43:07 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 08:43:07 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 08:43:09 INFO - Downloading blessings-1.6.tar.gz 08:43:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:09 INFO - Installing collected packages: blessings 08:43:09 INFO - Running setup.py install for blessings 08:43:09 INFO - Successfully installed blessings 08:43:09 INFO - Cleaning up... 08:43:09 INFO - Return code: 0 08:43:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:43:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:43:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:43:09 INFO - Reading from file tmpfile_stdout 08:43:09 INFO - Current package versions: 08:43:09 INFO - argparse == 1.2.1 08:43:09 INFO - blessings == 1.6 08:43:09 INFO - blobuploader == 1.2.4 08:43:09 INFO - docopt == 0.6.1 08:43:09 INFO - manifestparser == 1.1 08:43:09 INFO - mozInstall == 1.12 08:43:09 INFO - mozcrash == 0.16 08:43:09 INFO - mozdebug == 0.1 08:43:09 INFO - mozdevice == 0.48 08:43:09 INFO - mozfile == 1.2 08:43:09 INFO - mozhttpd == 0.7 08:43:09 INFO - mozinfo == 0.9 08:43:09 INFO - mozleak == 0.1 08:43:09 INFO - mozlog == 3.1 08:43:09 INFO - moznetwork == 0.27 08:43:09 INFO - mozprocess == 0.22 08:43:09 INFO - mozprofile == 0.28 08:43:09 INFO - mozrunner == 6.11 08:43:09 INFO - mozscreenshot == 0.1 08:43:09 INFO - mozsystemmonitor == 0.0 08:43:09 INFO - moztest == 0.7 08:43:09 INFO - mozversion == 1.4 08:43:09 INFO - psutil == 3.1.1 08:43:09 INFO - requests == 1.2.3 08:43:09 INFO - wsgiref == 0.1.2 08:43:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:09 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 0x7f5d8b318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c540>, '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 0x2a3d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', '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 08:43:09 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 08:43:09 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 08:43:09 INFO - Using env: {'DISPLAY': ':0', 08:43:09 INFO - 'HOME': '/home/cltbld', 08:43:09 INFO - 'LANG': 'en_US.UTF-8', 08:43:09 INFO - 'LANGUAGE': 'en_US:en', 08:43:09 INFO - 'LOGNAME': 'cltbld', 08:43:09 INFO - 'MAIL': '/var/mail/cltbld', 08:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:09 INFO - 'MOZ_NO_REMOTE': '1', 08:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:09 INFO - 'NO_EM_RESTART': '1', 08:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:43:09 INFO - 'PWD': '/builds/slave/test-pgo', 08:43:09 INFO - 'SHELL': '/bin/bash', 08:43:09 INFO - 'SHLVL': '1', 08:43:09 INFO - 'TERM': 'linux', 08:43:09 INFO - 'TMOUT': '86400', 08:43:09 INFO - 'USER': 'cltbld', 08:43:09 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', 08:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:09 INFO - '_': '/tools/buildbot/bin/python'} 08:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:10 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)) 08:43:10 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)) 08:43:10 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)) 08:43:10 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)) 08:43:10 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)) 08:43:10 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)) 08:43:10 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)) 08:43:10 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)) 08:43:10 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)) 08:43:10 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)) 08:43:10 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)) 08:43:10 INFO - Cleaning up... 08:43:10 INFO - Return code: 0 08:43:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:43:10 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')]} 08:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:10 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')]} 08:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:10 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 0x7f5d8b318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c540>, '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 0x2a3d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', '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 08:43:10 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 08:43:10 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 08:43:10 INFO - Using env: {'DISPLAY': ':0', 08:43:10 INFO - 'HOME': '/home/cltbld', 08:43:10 INFO - 'LANG': 'en_US.UTF-8', 08:43:10 INFO - 'LANGUAGE': 'en_US:en', 08:43:10 INFO - 'LOGNAME': 'cltbld', 08:43:10 INFO - 'MAIL': '/var/mail/cltbld', 08:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:10 INFO - 'MOZ_NO_REMOTE': '1', 08:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:10 INFO - 'NO_EM_RESTART': '1', 08:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:43:10 INFO - 'PWD': '/builds/slave/test-pgo', 08:43:10 INFO - 'SHELL': '/bin/bash', 08:43:10 INFO - 'SHLVL': '1', 08:43:10 INFO - 'TERM': 'linux', 08:43:10 INFO - 'TMOUT': '86400', 08:43:10 INFO - 'USER': 'cltbld', 08:43:10 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', 08:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:10 INFO - '_': '/tools/buildbot/bin/python'} 08:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:10 INFO - Downloading/unpacking jsonschema 08:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:12 INFO - Downloading/unpacking functools32 (from jsonschema) 08:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:12 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:12 INFO - warning: no files found matching '*.txt' 08:43:12 INFO - no previously-included directories found matching 'build' 08:43:12 INFO - no previously-included directories found matching 'dist' 08:43:12 INFO - no previously-included directories found matching '.git*' 08:43:12 INFO - Installing collected packages: jsonschema, functools32 08:43:12 INFO - Running setup.py install for functools32 08:43:12 INFO - warning: no files found matching '*.txt' 08:43:12 INFO - no previously-included directories found matching 'build' 08:43:12 INFO - no previously-included directories found matching 'dist' 08:43:12 INFO - no previously-included directories found matching '.git*' 08:43:12 INFO - Successfully installed jsonschema functools32 08:43:12 INFO - Cleaning up... 08:43:12 INFO - Return code: 0 08:43:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d8b318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c540>, '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 0x2a3d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', '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 08:43:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:43:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:43:12 INFO - Using env: {'DISPLAY': ':0', 08:43:12 INFO - 'HOME': '/home/cltbld', 08:43:12 INFO - 'LANG': 'en_US.UTF-8', 08:43:12 INFO - 'LANGUAGE': 'en_US:en', 08:43:12 INFO - 'LOGNAME': 'cltbld', 08:43:12 INFO - 'MAIL': '/var/mail/cltbld', 08:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:12 INFO - 'MOZ_NO_REMOTE': '1', 08:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:12 INFO - 'NO_EM_RESTART': '1', 08:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:43:12 INFO - 'PWD': '/builds/slave/test-pgo', 08:43:12 INFO - 'SHELL': '/bin/bash', 08:43:12 INFO - 'SHLVL': '1', 08:43:12 INFO - 'TERM': 'linux', 08:43:12 INFO - 'TMOUT': '86400', 08:43:12 INFO - 'USER': 'cltbld', 08:43:12 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', 08:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:12 INFO - '_': '/tools/buildbot/bin/python'} 08:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:12 INFO - Downloading/unpacking flake8 08:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:43:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:43:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:43:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:15 INFO - no previously-included directories found matching 'docs/_build' 08:43:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:43:15 INFO - Running setup.py install for pep8 08:43:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:15 INFO - no previously-included directories found matching 'docs/_build' 08:43:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:43:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:43:15 INFO - Cleaning up... 08:43:15 INFO - Return code: 0 08:43:15 INFO - Running post-action listener: _resource_record_post_action 08:43:15 INFO - Running post-action listener: _start_resource_monitoring 08:43:15 INFO - Starting resource monitoring. 08:43:15 INFO - ##### 08:43:15 INFO - ##### Running install step. 08:43:15 INFO - ##### 08:43:15 INFO - Running pre-action listener: _resource_record_pre_action 08:43:15 INFO - Running main action method: install 08:43:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:43:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:43:15 INFO - Reading from file tmpfile_stdout 08:43:15 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:43:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:43:15 INFO - Reading from file tmpfile_stdout 08:43:15 INFO - Output received: 08:43:15 INFO - Usage: mozinstall [options] installer 08:43:15 INFO - Options: 08:43:15 INFO - -h, --help show this help message and exit 08:43:15 INFO - -d DEST, --destination=DEST 08:43:15 INFO - Directory to install application into. [default: 08:43:15 INFO - "/builds/slave/test-pgo"] 08:43:15 INFO - --app=APP Application being installed. [default: firefox] 08:43:15 INFO - mkdir: /builds/slave/test-pgo/build/application 08:43:15 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'] 08:43:15 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 08:43:31 INFO - Reading from file tmpfile_stdout 08:43:31 INFO - Output received: 08:43:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:43:31 INFO - Running post-action listener: _resource_record_post_action 08:43:31 INFO - ##### 08:43:31 INFO - ##### Running run-tests step. 08:43:31 INFO - ##### 08:43:31 INFO - Running pre-action listener: _resource_record_pre_action 08:43:31 INFO - Running main action method: run_tests 08:43:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:43:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:43:31 INFO - Python 2.7.3 08:43:31 INFO - Return code: 0 08:43:31 INFO - grabbing minidump binary from tooltool 08:43:31 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')]} 08:43:31 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 0x2a3c540>, '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 0x2a3d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3d8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:43:31 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 08:43:31 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 08:43:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:31 INFO - Return code: 0 08:43:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:43:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:43:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:43:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:43:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:43:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:43:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:43:32 INFO - Return code: 0 08:43:32 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/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 08:43:32 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/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 08:43:32 INFO - Using env: {'DISPLAY': ':0', 08:43:32 INFO - 'HOME': '/home/cltbld', 08:43:32 INFO - 'LANG': 'en_US.UTF-8', 08:43:32 INFO - 'LANGUAGE': 'en_US:en', 08:43:32 INFO - 'LOGNAME': 'cltbld', 08:43:32 INFO - 'MAIL': '/var/mail/cltbld', 08:43:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:43:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:32 INFO - 'MOZ_NO_REMOTE': '1', 08:43:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:32 INFO - 'NO_EM_RESTART': '1', 08:43:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:43:32 INFO - 'PWD': '/builds/slave/test-pgo', 08:43:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:43:32 INFO - 'SHELL': '/bin/bash', 08:43:32 INFO - 'SHLVL': '1', 08:43:32 INFO - 'TERM': 'linux', 08:43:32 INFO - 'TMOUT': '86400', 08:43:32 INFO - 'USER': 'cltbld', 08:43:32 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559', 08:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:32 INFO - '_': '/tools/buildbot/bin/python'} 08:43:32 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/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 08:43:33 INFO - mozversion application_buildid: 20160125030203 08:43:33 INFO - mozversion application_changeset: 67c66c2878aed17ae3096d7db483ddbb2293c503 08:43:33 INFO - mozversion application_display_name: Nightly 08:43:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:33 INFO - mozversion application_name: Firefox 08:43:33 INFO - mozversion application_remotingname: firefox 08:43:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:43:33 INFO - mozversion application_vendor: Mozilla 08:43:33 INFO - mozversion application_version: 46.0a1 08:43:33 INFO - mozversion platform_buildid: 20160125030203 08:43:33 INFO - mozversion platform_changeset: 67c66c2878aed17ae3096d7db483ddbb2293c503 08:43:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:43:33 INFO - mozversion platform_version: 46.0a1 08:43:33 INFO - using testdate: 1453740213 08:43:33 INFO - actual date: 1453740213 08:43:33 INFO - starting webserver on 'localhost:52889' 08:43:33 INFO - SUITE-START | Running 3 tests 08:43:33 INFO - TEST-START | dromaeo_css 08:43:33 INFO - operating with platform_type : linux_ 08:43:33 INFO - Initialising browser for dromaeo_css test... 08:43:33 INFO - TEST-INFO | started process 1373 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpezn0YA/profile http://localhost:52889/getInfo.html) 08:43:36 INFO - PROCESS | 1373 | 08:43:36 INFO - PROCESS | 1373 | (process:1457): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:43:37 INFO - PROCESS | 1373 | __metrics Screen width/height:1600/1200 08:43:37 INFO - PROCESS | 1373 | colorDepth:24 08:43:37 INFO - PROCESS | 1373 | Browser inner width/height: 1024/697 08:43:37 INFO - PROCESS | 1373 | __metrics 08:43:37 INFO - PROCESS | 1373 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:43:39 INFO - TEST-INFO | 1373: exit 0 08:43:39 INFO - Browser initialized. 08:43:39 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:39 INFO - TEST-INFO | started process 1506 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpezn0YA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:40 INFO - PROCESS | 1506 | 08:43:40 INFO - PROCESS | 1506 | (process:1564): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:43:50 INFO - PROCESS | 1506 | RSS: Main: 150745088 08:43:50 INFO - PROCESS | 1506 | 08:44:40 INFO - PROCESS | 1506 | 1453740280416 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] 08:46:48 INFO - PROCESS | 1506 | Cycle 1(1): loaded http://localhost:52889/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52889/tests/dromaeo/cssquery-ext.html) 08:46:49 INFO - PROCESS | 1506 | RSS: Main: 160829440 08:46:49 INFO - PROCESS | 1506 | 08:49:51 INFO - PROCESS | 1506 | Cycle 1(1): loaded http://localhost:52889/tests/dromaeo/cssquery-ext.html (next: http://localhost:52889/tests/dromaeo/cssquery-jquery.html) 08:49:52 INFO - PROCESS | 1506 | RSS: Main: 155983872 08:49:52 INFO - PROCESS | 1506 | 08:52:54 INFO - PROCESS | 1506 | Cycle 1(1): loaded http://localhost:52889/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52889/tests/dromaeo/cssquery-mootools.html) 08:52:54 INFO - PROCESS | 1506 | RSS: Main: 156704768 08:52:54 INFO - PROCESS | 1506 | 08:55:56 INFO - PROCESS | 1506 | Cycle 1(1): loaded http://localhost:52889/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52889/tests/dromaeo/cssquery-prototype.html) 08:55:57 INFO - PROCESS | 1506 | RSS: Main: 154308608 08:55:57 INFO - PROCESS | 1506 | 08:58:59 INFO - PROCESS | 1506 | Cycle 1(1): loaded http://localhost:52889/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52889/tests/dromaeo/cssquery-yui.html) 08:59:00 INFO - PROCESS | 1506 | RSS: Main: 154611712 08:59:00 INFO - PROCESS | 1506 | 09:02:02 INFO - PROCESS | 1506 | Cycle 1(1): loaded http://localhost:52889/tests/dromaeo/cssquery-yui.html (next: http://localhost:52889/tests/dromaeo/cssquery-dojo.html) 09:02:02 INFO - PROCESS | 1506 | RSS: Main: 158367744 09:02:02 INFO - PROCESS | 1506 | 09:02:02 INFO - PROCESS | 1506 | __start_tp_report 09:02:02 INFO - PROCESS | 1506 | _x_x_mozilla_page_load 09:02:02 INFO - PROCESS | 1506 | _x_x_mozilla_page_load_details 09:02:02 INFO - PROCESS | 1506 | |i|pagename|runs| 09:02:02 INFO - PROCESS | 1506 | |0;dojo.html;3216;3236.9190770230744;3255.8372081395955;3275.148461400036;3290.588676415448;5233.555147812441;5262.6842389456615;5289.735513224343;5320.334958130234;5320.4679532046775;5227.137522308824;5254.973725131378;5317.229001794737;5333.626646134772;5352.2506849041065;4841.540053694902;4904.975475122619;4943.950560494385;4994.850154495371;5043.268726034723;626.9259709078879;4861;4865.099956508039;4935.185694360426;4949.331840201581;4974.253861920704;4981.900361992776;4993.925091123618;5003.524665156804;5050.74746262689;5002.699838009731;5005.524475174852;5011.674241174312;5013.799448022075;5082.593392528589;4794.400699912511;4815.085133824562;4860.295257187723;4909;5013.849584512471;5162.070827251093;5163.199704045879;5187.481251874782;5193.63644544882;5198.662086964335;5712;5715.828525144252;5717.113847353667;5725.885482290372;5745.138229265602;5722.885542289131;5743.396943320933;5766;5779.9422005779825;5840.094785308284;5435.782568697247;5454.427285135083;5456.48163424474;5464.12573988164;5475.5072043515875;5690.658560486384;5891.617044892068;5918.082697181943;5921.111833225051;5921.792737254175;5596.244506991586;5675.3757086720425;5713.028785106542;5726.169705392695;5765.682887441231;5673.375928647845;5757.510611598061;5757.596968212185;5759.481646651821;5775.393583673737;5568.053430916754;5667.4332566743;5720.256366672306;5731.083026715789;5741.942580574224;5650.63270887391;5651.660900345993;5711.343195532567;5715.714214289352;5748.48263656273;4360.324149756792;4419.337099435046;4423.823047078081;4433.467983841895;4437.955620443754;3890.708196885245;3966.920661586752;3967.2263908537557;3979.4030895365927;3981.6814654827544;5385.865353366197;5406.567474602022;5409.864753381118;5446.891062178814;5470.671759694352;5684.488396044293;5693.800716974886;5699.829005129853;5736.483716465538;5738.799142030009;5380.192971054373;5386.407495175527;5389.487998640123;5434.456554344613;5470.53500452466;4859.2954021666665;4906.8773280668265;4913.508649135058;4928.778204980785;4965.106280869478;5896.970515147483;5963.224780778558;5972.671503067286;5979.9402005980255;5992.34084250732;5601.943980560305;5652.491275785199;5673.659580425187;5742.363719469756;5781.364049954417;5901.203337549376;5950.702464876826;5970.373110823301;5973.910391344047;5974.850628734316;5623.465770751772;5626.959012582685;5634.295713035871;5635.154726791015;5645.68948707825;5592.049351610317;5674.347450043133;5702.144678298288;5704.600677952503;5721.313442386941;5581.302337207849;5619.606627536034;5634.85912852182;5638.23883775685;5704.1443783432815;5537;5556.055470570093;5568.16477528374;5584.497395234448;5593.356763972195;5406.918616276682;5432.34811822568;5436.592255580768;5505.064139096283;5507.972460137674;5594.664320140641;5633.943660563506;5667.093265077568;5671.574631902541;5696.373398926032;5508.008558459515;5515.779368825202;5526.751296191601;5531.170324451365;5541.778328866801 09:02:02 INFO - PROCESS | 1506 | |1;ext.html;515.2374485761073;525.9053370393327;547.1000204663328;562.2943206276123;570.7346084070907;27728.861355693218;34513.30973380534;34919.12702182447;34964.30071398571;34984.30031399371;38039.42940855889;38288;38456.42315365265;38716.41925371122;38868;8491.320694344453;8613.095624959384;8677.652893884237;8685.305175585938;8695.869561956575;8292.917070829275;8392.958035209815;8420.24217820396;8445.1977062179;8476.915230847706;8435.40952133351;8460.830783384328;8479.872801907977;8481.74554763355;8506.064332923374;8421.70524031659;8485.0666426693;8501.574921253943;8619.353548483889;8662.566871656454;8450.577471126418;8598.828023439559;8627.525486098262;8645.870311945326;8698.869516957251;37974;38265.23469530594;38300.23399532022;38357.23285534301;38454;3107.813531188136;3181.6341120771176;3198.5202219667003;3287.572615559962;3349.2129349602824;28700.712992870223;28734.568981465294;28859;29029;29347.70652293471;3454.4127498325347;3493.637266795482;3571.089372210096;3614.4397618369194;3719.628037196259;263054;263218;263459;266462.9999999981;266726;50490;51424.48575514272;56169;56397;56682.716586416806;59930.40069599248;60341.396586034454;60442.39557604368;60490.39509604935;60803.39196607978;11984.101192410604;12021.338826364634;12032.27806331623;12056.939715301367;12136.939315303367;9120.49837258957;9122.771930701652;9170.266378689688;9178.036306187887;9211.078892110736;18067.367642132464;18334.449966501026;18454.630907381776;19000.04999750007;19117;7267.927320726831;7520.360769334558;7554.848903022019;7577.696892124363;7583.810404739926;914.794171311463;956.3114557518576;970.5098925042809;979.2606582030663;1119.311623351633;24887;25075.37311567189;25317.240482785546;28461.146165615064;28898.85550572234;992.34009383759;1013.807376598444;1022.2946167144646;1087.043242380723;1104.3539529375246;13387.866121338857;13664.248466334247;13671.248081355421;13777.173369597856;13848;340785;342709;344041;345620;347217;49965;50094.74952625286;50493.74753126211;50640.74679626578;50707;1315.6316231455207;1317.5059352742721;1318.3803612302202;1333.2600955752835;1335.3723749837754;27042.729572704022;28052.298692532033;28182.29544261328;28554.85722571374;30940.22649433782;47169.528304716514;48633.270500941806;48890;48891.5110848887;49109.2633610489;200361;200744;202019;202208;203108;28696.282592935342;31452.213694657818;31524;32115.518267225543;32355.838220808746;36766.264674705824;36814.079648009014;36912.44631330478;37098.258034839695;37256.25487490181;31609.841950790098;34061.31877362389;34382.312353752284;34600.307993840484;34959.825200873835;34446.48330275098;34756.131096722784;35154.64845351616;36075.27849442944;36185.9241964436;32245.51631725573;34887.30225395427;35576.64423355733;35687;35772.28455430929;27017.72982270231;29633.407331853672;31565.210869728442;32862.507062394565;33250.833745831114;22938.655920160876;24152.63771043471;24435.04159187727;24475;24488.265352039467 09:02:02 INFO - PROCESS | 1506 | |2;jquery.html;359.1129909124463;363.8380920490382;365.29133481046773;367.81057755256046;370.6534390345029;11096.278741881772;11654.533818647265;15545.222738863054;16498;17405.47783566495;16814.411495597655;16816.663666726658;17714.822851771478;17719.291228350852;17750.911245443756;5533.3083364579325;5815.360310365856;5822.563307751914;5839.824805255828;5842.32813226478;5609.57928155388;6084.452399284063;6129.754809807602;6153.692315384235;6168.105624684418;5932.08052751822;6156;6161.383861613847;6181.690915454232;6429.646369449679;6349.333320001402;6357.523185761086;6380.680965951707;6448.742050318028;6728.730850765964;6229.190205273331;6437.227532696106;6453.322401147859;6453.612783233021;6465.159529261213;19895.50261243466;20505.4873628159;20764.68852967207;20858.5828283435;20883;2115.3442432845713;2225.265662331427;2294.2887704811396;2369;2475.084218839023;13436.596902092855;13789.793153102712;13872.653183670389;14181.43274269028;14185;1891.3947536788232;1928.6046360496064;1975.5357490989607;2009.6181725472259;2010.1155491583656;60847.391526085055;61581.692091539706;63042.36957630457;63649.68175159094;64131;14864.777028344584;14920.477783277533;14923.403063877324;14934.32795524204;14971.101733896001;22937;23079;23229.18697845601;23380.883095584413;23486.295411137693;7538.434617403716;7549.6225188740345;7582.696692132363;7655.425843061793;7655.885161722578;6192.845178870564;6284.748610055638;6292.528060395489;6413.29453760086;6498;7397.297256760599;7421.8144546386775;7469.253074692488;7478.401727861758;7676.53940763556;1775.5028591994262;1878.0891267735137;2918.9124326270244;3094.133642580081;3163.6519982801874;440.99118017639466;450.2211174667843;886.9822603548022;927.8051609162152;957.5834511987168;10133.18934485254;10282.948585257025;10646.095081918123;11026.393548354918;11083.947025032609;447.9595442758267;452.181551391975;459.3293791065082;462.89584843410637;480.29156993434407;5700.9429905701245;5904.793332233351;5939.4357536034;5957.344692083867;5989.251343582052;516918;544098;544547;553458;578020;72156;72202;72575.63712181406;72669;72706.81879543622;464.3406362964598;467.26172647217993;468.44021394434003;470.55297467406103;471.0907947661047;9778.60885564598;9876.555555000186;9878.950605246928;10048.497575121068;10080.54637541327;29987.250318742204;30582.847085764428;31408;31566.526502102028;32106.678933211304;42029;42551.7872410636;43844.56155438405;43929.56070439383;44337.33493997657;7253.56478611285;7425.851482970203;7455.888161677688;7459.962700186465;7582.62086895664;7728.806779830325;7912.36701063925;10779;11001.559937602406;11036.558537658404;7311.122665279988;7360.77917662471;7420.072490938633;7473.580019796222;7769.805754856174;7511.849763004819;7708.537487750753;7766.805829854073;7826.804329891798;7846;7433.450026430453;7739.690412383667;7760.188683016566;7793.64928578204;7973.9202607973175;8548.145185481402;8890.64437422496;8929.973053098976;9083.182513573545;9794.510274486389;3103.6120484939383;3793.355129628025;6398.552101353047;10015.449150296803;10318.896811032095 09:02:02 INFO - PROCESS | 1506 | |3;mootools.html;1418.0711633879807;1426.3438818143654;1578.3686525389842;1739.7999230088544;1777.2535535075267;7895.960520197398;7943.086545047321;8000.239977202171;8026.598670066495;8072.878906816402;8059.91940080599;8100.594970251494;8107.878381824277;8185.140560241178;8195.549244791535;2335.404471859678;2349.835511514195;2350.9412264693347;2360.126753101355;2360.36270207044;2294.128231272123;2311.0409180190286;2325.813934885205;2342.02805835578;2353.846999944998;2324.372419446748;2337.8363514553903;2338.555674421863;2358.622620380731;2388.7850093491584;2257.221258665758;2300.1259521381853;2309.93070207894;2310.8266879984067;2316.0504193280676;2382.0948039744785;2409.2531315292317;2421.794147497465;2426.1993542131054;2431.9148829790875;7994.440389172761;8053.275205231499;8054.9597252013955;8058.597070146469;8066.628673125583;4618.9076218475775;4640.280756482751;4676.625869930397;4712.175369310357;4716.740579268139;2937.574051762504;2944.1020488750924;2946.8673909674117;2960.881564737408;2982.120274519022;874.9606267717904;899.3929097858985;908.4140729229609;937.8686983822271;939.4410325856105;11262.324260544394;11346.48940797666;11353.069978103742;11369.431528423464;11371.772564548746;4061.6750659947133;4153.979230103831;4237.025484138665;4240.257954857949;4246.320588705792;9104.8634270486;9128.087191280818;9138.588763505659;9144.131307525775;9175.862362064574;4579.267317229227;4584.1977653910435;4629.930551041737;4642.048380082075;4648.5119062498625;4212.810423530948;4229.61933425987;4234.915301693949;4239.38528913312;4247.341662042389;3506.7194624429985;3526.2947410518;3557.2707594942976;3566.2510872716502;3586.7130629549574;1085.3270971997254;1110.0786347331696;1119.1494464207099;1121.4280716834473;1123.5955056179769;933.8412469880137;942.8962814090445;1118.9873164785881;1130.513879032024;1232.975340493203;7330.486865919334;7394.334509894028;7418.814529636695;7431.2197219292275;7457.32884040439;1193.2482536002262;1196.6170825335982;1220.4324988880214;1229.4590380232669;1237.0351126121639;5831.4168583141345;5898.616589921641;5919.319278283053;5928.584999050111;5934.258217722785;9253.491057991874;9952.80094398108;9960.501974901372;10035.79928401428;10065.798684026426;9856.950715246378;9862.753431164136;9882.308238423242;9938.950305248572;9976.401415915068;7422.255769894071;7605.543667379975;7688.769336919901;7713.4214933880185;7791.649375778104;7327.963360183165;7351.889721654286;7400.074990626172;7401.1488678802625;7432.925670743223;8518.957405212934;8785.868211976698;8826.602802873758;8879.866801998105;8903.065178156201;8727.825443491221;8793;8877.955610221907;8937.374383793072;9038.051004644418;7198.8920166198595;7276;7278.126624805057;7306.890396643948;7338.926610733824;7718.112417071884;7812.960935195288;7832;7883.487573307717;7910.9604451977375;7192.280771922766;7469.663865125974;7491.962540187482;7524.962375188089;7592.620368981639;7165.319294666998;7236.552689462023;7245.529040612343;7304.926950730637;7314.122305323395;7146.499745017799;7153.213146553979;7182.96408517954;7184.533005354635;7211;6565.146530950946;6596.571222870498;6604.471642268511;6631.1379520662;6685.39831415175;6546.770863019771;6618.569792963442;6688.464922806066;6690.765823196165;6709.161354830646 09:02:02 INFO - PROCESS | 1506 | |4;prototype.html;325.07678193929235;326.905197492727;335.6358351188959;336.79792124725185;340.96078950920634;6143.723532441039;6213.130161777349;6253.874922501547;6357.173567436238;6357.205349331333;6023.638581685102;6187.288461826891;6196.59722118062;6226.564140510155;6238.875222495547;4744.881377965544;4762.880927976811;4767.618590512768;4781.5218478152165;4786.090642777861;4763.85708428746;4771.9761401192945;4781.832635857746;4789.353437285974;4790.281457781326;4639.932815452448;4696.154692155428;4741.407324084489;4747.1692453820615;4767.976160119195;4709.317149013391;4732.763361831895;4736.692115012514;4742.620590352763;4763;4135.60711732385;4139.544650088488;4155.127423241123;4155.148194620096;4157.334826427787;5825.300963884319;5880.147378630118;5884.9705751470965;5885.470307672287;5899.764009439617;5412.404635490093;5424.945750542483;5469.863253418696;5470.7264636768;5482.17767334899;6515.218173819172;6526.477881769447;6533.346665333429;6536;6565.606063636149;4505.662075344329;4507.008458139204;4523.321501774727;4544.727316360996;4546.181687296285;6683.431908287801;6853.314668533157;6876.762182807092;6921.826954326182;6929.203141638776;4459.732416055047;4462.620677242471;4486.910261794811;4492.775361231926;4494.303382975644;4519.774011299488;4556.7721613919175;4557.361969324297;4562.749048802348;4581.65637577183;5310.044192045469;5313.203019547099;5315;5315.654482458628;5319.0957537218765;6410;6467.094606755058;6485.70814313357;6533.216014078246;6570.408663220333;1599.8160211575819;1604.8555629993357;1640.409452597064;1648.4477699970644;1650.414102993444;1056.3556230699267;1058.4760543531002;1069.6256310291335;1075.4568942683895;1082.4533610526635;6177.938220617826;6218.1916350875;6238.844028899223;6274;6281.2462504498835;6655.534112612071;6696.732130714814;6739.427148692318;6747.730090796412;6795.354441328066;6102.267727872595;6216;6231.813045608639;6240.095186198067;6260.937390626035;3685.9078523037138;3704.6665800077585;3705;3708.9258214835554;3710.18375957289;7149.642517874086;7150.855863061989;7153.642317884189;7156.713731450788;7158.8210294742;6679.899801502981;6921.8961715574305;6930.272321406281;6943.756968506179;6950.687219075154;7079.1505019398;7083.397911177504;7105.964470177616;7141.9642901785155;7145.499815013003;6716.899246511404;6722.092517510074;6725.9663701681175;6739.764108256188;6783.559068660521;6561.507886908405;6658.766943156967;6671.933280667326;6711.194656641234;6716.194056713226;7061.293870612898;7098.432125430057;7104.573725576482;7107;7132.251113632994;4513.074819661896;4557.339185818104;4574.496805351475;4578.725276483422;4579.542045795394;6672.132622759011;6741.325867413219;6753.3246675332075;6753.649270145892;6955.443564514725;6719.294474080151;6727.562708423937;6746.4940129489505;6768.255491895789;6783.660816959034;6692.531522793358;6700.564463309869;6704.061431399706;6714.026466162281;6722.899156512754;6413.551051426542;6521.836954076186;6526.086347911391;6550.410463058157;6634.933650663432;6755.93244067553;6759.5606285591275;6764.4588432924265;6837.589744615339;6838.281980392187;6549.115869357766;6572.8356791080605;6608.768693095719;6615.966920165561;6628.966855165693 09:02:02 INFO - PROCESS | 1506 | |5;yui.html;701.0115736811094;714.8606021825746;738.7968308715105;774.5159275452842;867.4014929698508;14349.210793406359;14350.497732579362;14356.066855654375;14391.280435978186;14400.71198576028;13016.544420945245;13072.673183170426;13086.93456532716;13101.606951791438;13106.344682765872;661.8345413646589;794.086800179795;797.4139007829241;798.480987358219;800.5997001499251;662.8276648071512;791.6754130806371;798.4131663227552;801.3989507869098;801.8596745569502;821.6015232612178;823.3660081737058;828.225609055532;828.4821986258588;832.1013305629936;818.2267756969666;818.639798488669;821.9807438775935;825.3273582030656;826.921442462965;605.5882000239835;607.9544034197453;608.7930103764742;609.2171559546007;609.881073190728;12495.625131246077;12598.307093109875;12618.432170552347;12636.05229607774;12653.936730316289;11494.770104597945;11545.30728156305;11575.610926688767;11746.353950532717;11883.87967298994;9838.458884761336;9862.112409883144;9888.802223955481;9891.35706179096;10022.298439109265;3284.5894263217097;3329.6170940341926;3374.7806392584403;3412.1640198151363;3440.3291358185165;45223.321650175276;45927.31109033367;46101;46243.768781156214;46255;9280.535973201448;9281.21109705669;9325.580348884316;9359;9501.762455938519;16531.256093475822;16652.16739163037;16673;16896.831031689773;16967.236474358684;6514.771982980573;6594.538382313192;6603;6734.494912881553;6822.658867056627;3943.1719338939142;4022.2960981828064;4023.4970628671417;4035.3139966205817;4126.051008268115;2953.1731115287753;2985.11938978002;2987.8207307561615;2988.1483777123417;3004.1137864330076;562.0922210629885;565.7934853778341;582.8076734677546;589.3664310865751;589.4135335341277;588.9499392551681;641.8299150725062;647.4043879630657;680.7038938061959;716.5020310883885;8158.796030099295;8337.833243335099;8337.95831020853;8339.791505212419;8346.666133354598;560.9971950140223;568.3747877334981;699.4928676709446;713.5718568858747;725.7351066860558;3798.6201379862346;3897.707671924617;4142.5857414258935;4158.750474971512;4229.577042295746;55513.722431387585;55727.164092538645;55838.441615583324;56195.71902140463;56212.71893640587;48318;48939.51060489421;49320.75339623351;49611.751941240065;49636.50363496391;43996;44026.11947761027;44475.55524444714;44667.553324466986;45269.32096018562;8153.714619988272;8230.83538329242;8247.21651443112;8421.578921054046;8503.957480212559;31954.520682189323;32309.838450807594;32539.186520336232;33337.666623333454;34066.65933340734;42276;42551.36172957346;42569.787151065284;42647.36028959506;42789;10604.628837990942;10665.626703065356;10799.622013229498;10867.673969780919;10926.344419334548;11577.305361678325;11588.246763960316;11730.002949749025;11785.292882427082;12032.458539365925;10826.729331766768;11108.277961932448;11241.269317494336;11352.148588856035;11693.707657308636;10709;10752.40861752611;11138.610148644759;11147.219694621299;11472.12949112929;9970.215233347057;10444.112250458797;10876.12990960737;10923.344599324066;10965.177611678997;9061;9147.496887670975;9186.58660360272;9312.906870931203;9415.858762118436;9001.684941027033;9018.954905225432;9487.857682134912;9602.32783705134;9649.179819715122 09:02:02 INFO - PROCESS | 1506 | __end_tp_report 09:02:02 INFO - PROCESS | 1506 | __start_cc_report 09:02:02 INFO - PROCESS | 1506 | _x_x_mozilla_cycle_collect,315 09:02:02 INFO - PROCESS | 1506 | __end_cc_report 09:02:02 INFO - PROCESS | 1506 | __startTimestamp1453741322851__endTimestamp 09:02:02 INFO - PROCESS | 1506 | 09:02:02 INFO - PROCESS | 1506 | ------- Summary: start ------- 09:02:02 INFO - PROCESS | 1506 | Number of tests: 6 09:02:02 INFO - PROCESS | 1506 | 09:02:02 INFO - PROCESS | 1506 | [#0] dojo.html Cycles:165 Average:5307.43 Median:5531.17 stddev:680.99 (12.3%) stddev-sans-first:663.02 09:02:02 INFO - PROCESS | 1506 | Values: 3216.0 3236.9 3255.8 3275.1 3290.6 5233.6 5262.7 5289.7 5320.3 5320.5 5227.1 5255.0 5317.2 5333.6 5352.3 4841.5 4905.0 4944.0 4994.9 5043.3 626.9 4861.0 4865.1 4935.2 4949.3 4974.3 4981.9 4993.9 5003.5 5050.7 5002.7 5005.5 5011.7 5013.8 5082.6 4794.4 4815.1 4860.3 4909.0 5013.8 5162.1 5163.2 5187.5 5193.6 5198.7 5712.0 5715.8 5717.1 5725.9 5745.1 5722.9 5743.4 5766.0 5779.9 5840.1 5435.8 5454.4 5456.5 5464.1 5475.5 5690.7 5891.6 5918.1 5921.1 5921.8 5596.2 5675.4 5713.0 5726.2 5765.7 5673.4 5757.5 5757.6 5759.5 5775.4 5568.1 5667.4 5720.3 5731.1 5741.9 5650.6 5651.7 5711.3 5715.7 5748.5 4360.3 4419.3 4423.8 4433.5 4438.0 3890.7 3966.9 3967.2 3979.4 3981.7 5385.9 5406.6 5409.9 5446.9 5470.7 5684.5 5693.8 5699.8 5736.5 5738.8 5380.2 5386.4 5389.5 5434.5 5470.5 4859.3 4906.9 4913.5 4928.8 4965.1 5897.0 5963.2 5972.7 5979.9 5992.3 5601.9 5652.5 5673.7 5742.4 5781.4 5901.2 5950.7 5970.4 5973.9 5974.9 5623.5 5627.0 5634.3 5635.2 5645.7 5592.0 5674.3 5702.1 5704.6 5721.3 5581.3 5619.6 5634.9 5638.2 5704.1 5537.0 5556.1 5568.2 5584.5 5593.4 5406.9 5432.3 5436.6 5505.1 5508.0 5594.7 5633.9 5667.1 5671.6 5696.4 5508.0 5515.8 5526.8 5531.2 5541.8 09:02:02 INFO - PROCESS | 1506 | 09:02:02 INFO - PROCESS | 1506 | [#1] ext.html Cycles:180 Average:43323.49 Median:35069.47 stddev:72493.48 (206.7%) stddev-sans-first:72625.59 09:02:02 INFO - PROCESS | 1506 | Values: 515.2 525.9 547.1 562.3 570.7 27728.9 34513.3 34919.1 34964.3 34984.3 38039.4 38288.0 38456.4 38716.4 38868.0 8491.3 8613.1 8677.7 8685.3 8695.9 8292.9 8393.0 8420.2 8445.2 8476.9 8435.4 8460.8 8479.9 8481.7 8506.1 8421.7 8485.1 8501.6 8619.4 8662.6 8450.6 8598.8 8627.5 8645.9 8698.9 37974.0 38265.2 38300.2 38357.2 38454.0 3107.8 3181.6 3198.5 3287.6 3349.2 28700.7 28734.6 28859.0 29029.0 29347.7 3454.4 3493.6 3571.1 3614.4 3719.6 263054.0 263218.0 263459.0 266463.0 266726.0 50490.0 51424.5 56169.0 56397.0 56682.7 59930.4 60341.4 60442.4 60490.4 60803.4 11984.1 12021.3 12032.3 12056.9 12136.9 9120.5 9122.8 9170.3 9178.0 9211.1 18067.4 18334.4 18454.6 19000.0 19117.0 7267.9 7520.4 7554.8 7577.7 7583.8 914.8 956.3 970.5 979.3 1119.3 24887.0 25075.4 25317.2 28461.1 28898.9 992.3 1013.8 1022.3 1087.0 1104.4 13387.9 13664.2 13671.2 13777.2 13848.0 340785.0 342709.0 344041.0 345620.0 347217.0 49965.0 50094.7 50493.7 50640.7 50707.0 1315.6 1317.5 1318.4 1333.3 1335.4 27042.7 28052.3 28182.3 28554.9 30940.2 47169.5 48633.3 48890.0 48891.5 49109.3 200361.0 200744.0 202019.0 202208.0 203108.0 28696.3 31452.2 31524.0 32115.5 32355.8 36766.3 36814.1 36912.4 37098.3 37256.3 31609.8 34061.3 34382.3 34600.3 34959.8 34446.5 34756.1 35154.6 36075.3 36185.9 32245.5 34887.3 35576.6 35687.0 35772.3 27017.7 29633.4 31565.2 32862.5 33250.8 22938.7 24152.6 24435.0 24475.0 24488.3 09:02:02 INFO - PROCESS | 1506 | 09:02:02 INFO - PROCESS | 1506 | [#2] jquery.html Cycles:180 Average:27911.81 Median:279533.79 stddev:89534.40 (32.0%) stddev-sans-first:89761.67 09:02:02 INFO - PROCESS | 1506 | Values: 359.1 363.8 365.3 367.8 370.7 11096.3 11654.5 15545.2 16498.0 17405.5 16814.4 16816.7 17714.8 17719.3 17750.9 5533.3 5815.4 5822.6 5839.8 5842.3 5609.6 6084.5 6129.8 6153.7 6168.1 5932.1 6156.0 6161.4 6181.7 6429.6 6349.3 6357.5 6380.7 6448.7 6728.7 6229.2 6437.2 6453.3 6453.6 6465.2 19895.5 20505.5 20764.7 20858.6 20883.0 2115.3 2225.3 2294.3 2369.0 2475.1 13436.6 13789.8 13872.7 14181.4 14185.0 1891.4 1928.6 1975.5 2009.6 2010.1 60847.4 61581.7 63042.4 63649.7 64131.0 14864.8 14920.5 14923.4 14934.3 14971.1 22937.0 23079.0 23229.2 23380.9 23486.3 7538.4 7549.6 7582.7 7655.4 7655.9 6192.8 6284.7 6292.5 6413.3 6498.0 7397.3 7421.8 7469.3 7478.4 7676.5 1775.5 1878.1 2918.9 3094.1 3163.7 441.0 450.2 887.0 927.8 957.6 10133.2 10282.9 10646.1 11026.4 11083.9 448.0 452.2 459.3 462.9 480.3 5700.9 5904.8 5939.4 5957.3 5989.3 516918.0 544098.0 544547.0 553458.0 578020.0 72156.0 72202.0 72575.6 72669.0 72706.8 464.3 467.3 468.4 470.6 471.1 9778.6 9876.6 9879.0 10048.5 10080.5 29987.3 30582.8 31408.0 31566.5 32106.7 42029.0 42551.8 43844.6 43929.6 44337.3 7253.6 7425.9 7455.9 7460.0 7582.6 7728.8 7912.4 10779.0 11001.6 11036.6 7311.1 7360.8 7420.1 7473.6 7769.8 7511.8 7708.5 7766.8 7826.8 7846.0 7433.5 7739.7 7760.2 7793.6 7973.9 8548.1 8890.6 8930.0 9083.2 9794.5 3103.6 3793.4 6398.6 10015.4 10318.9 09:02:02 INFO - PROCESS | 1506 | 09:02:02 INFO - PROCESS | 1506 | [#3] mootools.html Cycles:180 Average:5625.18 Median:6658.27 stddev:2981.68 (44.8%) stddev-sans-first:2973.27 09:02:02 INFO - PROCESS | 1506 | Values: 1418.1 1426.3 1578.4 1739.8 1777.3 7896.0 7943.1 8000.2 8026.6 8072.9 8059.9 8100.6 8107.9 8185.1 8195.5 2335.4 2349.8 2350.9 2360.1 2360.4 2294.1 2311.0 2325.8 2342.0 2353.8 2324.4 2337.8 2338.6 2358.6 2388.8 2257.2 2300.1 2309.9 2310.8 2316.1 2382.1 2409.3 2421.8 2426.2 2431.9 7994.4 8053.3 8055.0 8058.6 8066.6 4618.9 4640.3 4676.6 4712.2 4716.7 2937.6 2944.1 2946.9 2960.9 2982.1 875.0 899.4 908.4 937.9 939.4 11262.3 11346.5 11353.1 11369.4 11371.8 4061.7 4154.0 4237.0 4240.3 4246.3 9104.9 9128.1 9138.6 9144.1 9175.9 4579.3 4584.2 4629.9 4642.0 4648.5 4212.8 4229.6 4234.9 4239.4 4247.3 3506.7 3526.3 3557.3 3566.3 3586.7 1085.3 1110.1 1119.1 1121.4 1123.6 933.8 942.9 1119.0 1130.5 1233.0 7330.5 7394.3 7418.8 7431.2 7457.3 1193.2 1196.6 1220.4 1229.5 1237.0 5831.4 5898.6 5919.3 5928.6 5934.3 9253.5 9952.8 9960.5 10035.8 10065.8 9857.0 9862.8 9882.3 9939.0 9976.4 7422.3 7605.5 7688.8 7713.4 7791.6 7328.0 7351.9 7400.1 7401.1 7432.9 8519.0 8785.9 8826.6 8879.9 8903.1 8727.8 8793.0 8878.0 8937.4 9038.1 7198.9 7276.0 7278.1 7306.9 7338.9 7718.1 7813.0 7832.0 7883.5 7911.0 7192.3 7469.7 7492.0 7525.0 7592.6 7165.3 7236.6 7245.5 7304.9 7314.1 7146.5 7153.2 7183.0 7184.5 7211.0 6565.1 6596.6 6604.5 6631.1 6685.4 6546.8 6618.6 6688.5 6690.8 6709.2 09:02:02 INFO - PROCESS | 1506 | 09:02:02 INFO - PROCESS | 1506 | [#4] prototype.html Cycles:180 Average:5498.44 Median:6235.33 stddev:1682.89 (27.0%) stddev-sans-first:1642.21 09:02:02 INFO - PROCESS | 1506 | Values: 325.1 326.9 335.6 336.8 341.0 6143.7 6213.1 6253.9 6357.2 6357.2 6023.6 6187.3 6196.6 6226.6 6238.9 4744.9 4762.9 4767.6 4781.5 4786.1 4763.9 4772.0 4781.8 4789.4 4790.3 4639.9 4696.2 4741.4 4747.2 4768.0 4709.3 4732.8 4736.7 4742.6 4763.0 4135.6 4139.5 4155.1 4155.1 4157.3 5825.3 5880.1 5885.0 5885.5 5899.8 5412.4 5424.9 5469.9 5470.7 5482.2 6515.2 6526.5 6533.3 6536.0 6565.6 4505.7 4507.0 4523.3 4544.7 4546.2 6683.4 6853.3 6876.8 6921.8 6929.2 4459.7 4462.6 4486.9 4492.8 4494.3 4519.8 4556.8 4557.4 4562.7 4581.7 5310.0 5313.2 5315.0 5315.7 5319.1 6410.0 6467.1 6485.7 6533.2 6570.4 1599.8 1604.9 1640.4 1648.4 1650.4 1056.4 1058.5 1069.6 1075.5 1082.5 6177.9 6218.2 6238.8 6274.0 6281.2 6655.5 6696.7 6739.4 6747.7 6795.4 6102.3 6216.0 6231.8 6240.1 6260.9 3685.9 3704.7 3705.0 3708.9 3710.2 7149.6 7150.9 7153.6 7156.7 7158.8 6679.9 6921.9 6930.3 6943.8 6950.7 7079.2 7083.4 7106.0 7142.0 7145.5 6716.9 6722.1 6726.0 6739.8 6783.6 6561.5 6658.8 6671.9 6711.2 6716.2 7061.3 7098.4 7104.6 7107.0 7132.3 4513.1 4557.3 4574.5 4578.7 4579.5 6672.1 6741.3 6753.3 6753.6 6955.4 6719.3 6727.6 6746.5 6768.3 6783.7 6692.5 6700.6 6704.1 6714.0 6722.9 6413.6 6521.8 6526.1 6550.4 6634.9 6755.9 6759.6 6764.5 6837.6 6838.3 6549.1 6572.8 6608.8 6616.0 6629.0 09:02:02 INFO - PROCESS | 1506 | 09:02:02 INFO - PROCESS | 1506 | [#5] yui.html Cycles:180 Average:13243.24 Median:48628.76 stddev:15296.40 (31.5%) stddev-sans-first:15310.31 09:02:02 INFO - PROCESS | 1506 | Values: 701.0 714.9 738.8 774.5 867.4 14349.2 14350.5 14356.1 14391.3 14400.7 13016.5 13072.7 13086.9 13101.6 13106.3 661.8 794.1 797.4 798.5 800.6 662.8 791.7 798.4 801.4 801.9 821.6 823.4 828.2 828.5 832.1 818.2 818.6 822.0 825.3 826.9 605.6 608.0 608.8 609.2 609.9 12495.6 12598.3 12618.4 12636.1 12653.9 11494.8 11545.3 11575.6 11746.4 11883.9 9838.5 9862.1 9888.8 9891.4 10022.3 3284.6 3329.6 3374.8 3412.2 3440.3 45223.3 45927.3 46101.0 46243.8 46255.0 9280.5 9281.2 9325.6 9359.0 9501.8 16531.3 16652.2 16673.0 16896.8 16967.2 6514.8 6594.5 6603.0 6734.5 6822.7 3943.2 4022.3 4023.5 4035.3 4126.1 2953.2 2985.1 2987.8 2988.1 3004.1 562.1 565.8 582.8 589.4 589.4 588.9 641.8 647.4 680.7 716.5 8158.8 8337.8 8338.0 8339.8 8346.7 561.0 568.4 699.5 713.6 725.7 3798.6 3897.7 4142.6 4158.8 4229.6 55513.7 55727.2 55838.4 56195.7 56212.7 48318.0 48939.5 49320.8 49611.8 49636.5 43996.0 44026.1 44475.6 44667.6 45269.3 8153.7 8230.8 8247.2 8421.6 8504.0 31954.5 32309.8 32539.2 33337.7 34066.7 42276.0 42551.4 42569.8 42647.4 42789.0 10604.6 10665.6 10799.6 10867.7 10926.3 11577.3 11588.2 11730.0 11785.3 12032.5 10826.7 11108.3 11241.3 11352.1 11693.7 10709.0 10752.4 11138.6 11147.2 11472.1 9970.2 10444.1 10876.1 10923.3 10965.2 9061.0 9147.5 9186.6 9312.9 9415.9 9001.7 9019.0 9487.9 9602.3 9649.2 09:02:02 INFO - PROCESS | 1506 | -------- Summary: end -------- 09:02:02 INFO - PROCESS | 1506 | 09:02:03 INFO - TEST-INFO | 1506: exit 0 09:02:03 INFO - TEST-OK | dromaeo_css | took 1110341ms 09:02:03 INFO - TEST-START | kraken 09:02:03 INFO - operating with platform_type : linux_ 09:02:03 INFO - Initialising browser for kraken test... 09:02:03 INFO - TEST-INFO | started process 1745 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKhtVwh/profile http://localhost:52889/getInfo.html) 09:02:07 INFO - PROCESS | 1745 | 09:02:07 INFO - PROCESS | 1745 | (process:1815): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:02:07 INFO - PROCESS | 1745 | __metrics Screen width/height:1600/1200 09:02:07 INFO - PROCESS | 1745 | colorDepth:24 09:02:07 INFO - PROCESS | 1745 | Browser inner width/height: 1024/697 09:02:07 INFO - PROCESS | 1745 | __metrics 09:02:07 INFO - PROCESS | 1745 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:02:08 INFO - TEST-INFO | 1745: exit 0 09:02:08 INFO - Browser initialized. 09:02:08 INFO - Running cycle 1/1 for kraken test... 09:02:08 INFO - TEST-INFO | started process 1864 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKhtVwh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:10 INFO - PROCESS | 1864 | 09:02:10 INFO - PROCESS | 1864 | (process:1924): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:02:20 INFO - PROCESS | 1864 | RSS: Main: 152248320 09:02:20 INFO - PROCESS | 1864 | 09:02:23 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52889/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:23 INFO - PROCESS | 1864 | RSS: Main: 155258880 09:02:23 INFO - PROCESS | 1864 | 09:02:26 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52889/tests/kraken/driver.html?testName=audio-dft) 09:02:27 INFO - PROCESS | 1864 | RSS: Main: 159379456 09:02:27 INFO - PROCESS | 1864 | 09:02:29 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52889/tests/kraken/driver.html?testName=audio-fft) 09:02:30 INFO - PROCESS | 1864 | RSS: Main: 154103808 09:02:30 INFO - PROCESS | 1864 | 09:02:32 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52889/tests/kraken/driver.html?testName=audio-oscillator) 09:02:33 INFO - PROCESS | 1864 | RSS: Main: 154247168 09:02:33 INFO - PROCESS | 1864 | 09:02:35 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52889/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:36 INFO - PROCESS | 1864 | RSS: Main: 154365952 09:02:36 INFO - PROCESS | 1864 | 09:02:39 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52889/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:39 INFO - PROCESS | 1864 | RSS: Main: 154066944 09:02:39 INFO - PROCESS | 1864 | 09:02:43 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52889/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:43 INFO - PROCESS | 1864 | RSS: Main: 153985024 09:02:43 INFO - PROCESS | 1864 | 09:02:46 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52889/tests/kraken/driver.html?testName=json-parse-financial) 09:02:47 INFO - PROCESS | 1864 | RSS: Main: 154624000 09:02:47 INFO - PROCESS | 1864 | 09:02:48 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52889/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:49 INFO - PROCESS | 1864 | RSS: Main: 155750400 09:02:49 INFO - PROCESS | 1864 | 09:02:51 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52889/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:51 INFO - PROCESS | 1864 | RSS: Main: 155152384 09:02:51 INFO - PROCESS | 1864 | 09:02:53 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52889/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:54 INFO - PROCESS | 1864 | RSS: Main: 154558464 09:02:54 INFO - PROCESS | 1864 | 09:02:56 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:57 INFO - PROCESS | 1864 | RSS: Main: 155414528 09:02:57 INFO - PROCESS | 1864 | 09:02:59 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:00 INFO - PROCESS | 1864 | RSS: Main: 154570752 09:03:00 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | Cycle 1(1): loaded http://localhost:52889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52889/tests/kraken/driver.html?testName=ai-astar) 09:03:02 INFO - PROCESS | 1864 | RSS: Main: 157155328 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | __start_tp_report 09:03:02 INFO - PROCESS | 1864 | _x_x_mozilla_page_load 09:03:02 INFO - PROCESS | 1864 | _x_x_mozilla_page_load_details 09:03:02 INFO - PROCESS | 1864 | |i|pagename|runs| 09:03:02 INFO - PROCESS | 1864 | |0;ai-astar;112;107;113;112;114;124;111;112;112;112 09:03:02 INFO - PROCESS | 1864 | |1;audio-beat-detection;157;129;150;169;130;152;155;131;175;133 09:03:02 INFO - PROCESS | 1864 | |2;audio-dft;163;162;161;161;161;160;161;164;174;161 09:03:02 INFO - PROCESS | 1864 | |3;audio-fft;75;75;74;77;73;130;76;77;73;74 09:03:02 INFO - PROCESS | 1864 | |4;audio-oscillator;98;97;143;97;97;98;147;98;98;140 09:03:02 INFO - PROCESS | 1864 | |5;imaging-gaussian-blur;110;114;114;110;110;109;110;111;110;110 09:03:02 INFO - PROCESS | 1864 | |6;imaging-darkroom;147;147;147;146;146;146;147;146;146;146 09:03:02 INFO - PROCESS | 1864 | |7;imaging-desaturate;97;96;96;97;97;97;96;96;96;97 09:03:02 INFO - PROCESS | 1864 | |8;json-parse-financial;60;60;68;60;62;59;63;68;73;57 09:03:02 INFO - PROCESS | 1864 | |9;json-stringify-tinderbox;68;68;70;70;67;68;67;67;69;68 09:03:02 INFO - PROCESS | 1864 | |10;stanford-crypto-aes;85;81;84;90;90;83;84;83;83;84 09:03:02 INFO - PROCESS | 1864 | |11;stanford-crypto-ccm;120;128;111;116;123;122;119;129;121;122 09:03:02 INFO - PROCESS | 1864 | |12;stanford-crypto-pbkdf2;130;132;147;141;144;131;142;151;139;142 09:03:02 INFO - PROCESS | 1864 | |13;stanford-crypto-sha256-iterative;67;65;67;68;67;67;67;67;68;66 09:03:02 INFO - PROCESS | 1864 | __end_tp_report 09:03:02 INFO - PROCESS | 1864 | __start_cc_report 09:03:02 INFO - PROCESS | 1864 | _x_x_mozilla_cycle_collect,721 09:03:02 INFO - PROCESS | 1864 | __end_cc_report 09:03:02 INFO - PROCESS | 1864 | __startTimestamp1453741382428__endTimestamp 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | ------- Summary: start ------- 09:03:02 INFO - PROCESS | 1864 | Number of tests: 14 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.00 stddev:4.31 (3.8%) stddev-sans-first:4.56 09:03:02 INFO - PROCESS | 1864 | Values: 112.0 107.0 113.0 112.0 114.0 124.0 111.0 112.0 112.0 112.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:153.50 stddev:16.73 (10.9%) stddev-sans-first:17.43 09:03:02 INFO - PROCESS | 1864 | Values: 157.0 129.0 150.0 169.0 130.0 152.0 155.0 131.0 175.0 133.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#2] audio-dft Cycles:10 Average:162.80 Median:161.50 stddev:4.10 (2.5%) stddev-sans-first:4.35 09:03:02 INFO - PROCESS | 1864 | Values: 163.0 162.0 161.0 161.0 161.0 160.0 161.0 164.0 174.0 161.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:17.49 (23.3%) stddev-sans-first:18.44 09:03:02 INFO - PROCESS | 1864 | Values: 75.0 75.0 74.0 77.0 73.0 130.0 76.0 77.0 73.0 74.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#4] audio-oscillator Cycles:10 Average:111.30 Median:97.50 stddev:22.17 (22.7%) stddev-sans-first:22.99 09:03:02 INFO - PROCESS | 1864 | Values: 98.0 97.0 143.0 97.0 97.0 98.0 147.0 98.0 98.0 140.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:110.00 stddev:1.75 (1.6%) stddev-sans-first:1.83 09:03:02 INFO - PROCESS | 1864 | Values: 110.0 114.0 114.0 110.0 110.0 109.0 110.0 111.0 110.0 110.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:03:02 INFO - PROCESS | 1864 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:03:02 INFO - PROCESS | 1864 | Values: 97.0 96.0 96.0 97.0 97.0 97.0 96.0 96.0 96.0 97.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:62.50 stddev:5.06 (8.1%) stddev-sans-first:5.24 09:03:02 INFO - PROCESS | 1864 | Values: 60.0 60.0 68.0 60.0 62.0 59.0 63.0 68.0 73.0 57.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 09:03:02 INFO - PROCESS | 1864 | Values: 68.0 68.0 70.0 70.0 67.0 68.0 67.0 67.0 69.0 68.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:2.98 (3.6%) stddev-sans-first:3.16 09:03:02 INFO - PROCESS | 1864 | Values: 85.0 81.0 84.0 90.0 90.0 83.0 84.0 83.0 83.0 84.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:122.00 stddev:5.26 (4.3%) stddev-sans-first:5.56 09:03:02 INFO - PROCESS | 1864 | Values: 120.0 128.0 111.0 116.0 123.0 122.0 119.0 129.0 121.0 122.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.90 Median:142.00 stddev:7.00 (4.9%) stddev-sans-first:6.44 09:03:02 INFO - PROCESS | 1864 | Values: 130.0 132.0 147.0 141.0 144.0 131.0 142.0 151.0 139.0 142.0 09:03:02 INFO - PROCESS | 1864 | 09:03:02 INFO - PROCESS | 1864 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 09:03:02 INFO - PROCESS | 1864 | Values: 67.0 65.0 67.0 68.0 67.0 67.0 67.0 67.0 68.0 66.0 09:03:02 INFO - PROCESS | 1864 | -------- Summary: end -------- 09:03:02 INFO - PROCESS | 1864 | 09:03:03 INFO - TEST-INFO | 1864: exit 0 09:03:03 INFO - TEST-OK | kraken | took 59936ms 09:03:03 INFO - TEST-START | v8_7 09:03:03 INFO - operating with platform_type : linux_ 09:03:03 INFO - Initialising browser for v8_7 test... 09:03:03 INFO - TEST-INFO | started process 2152 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYC4u2e/profile http://localhost:52889/getInfo.html) 09:03:06 INFO - PROCESS | 2152 | 09:03:06 INFO - PROCESS | 2152 | (process:2224): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:03:07 INFO - PROCESS | 2152 | __metrics Screen width/height:1600/1200 09:03:07 INFO - PROCESS | 2152 | colorDepth:24 09:03:07 INFO - PROCESS | 2152 | Browser inner width/height: 1024/697 09:03:07 INFO - PROCESS | 2152 | __metrics 09:03:07 INFO - PROCESS | 2152 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:03:08 INFO - TEST-INFO | 2152: exit 0 09:03:08 INFO - Browser initialized. 09:03:08 INFO - Running cycle 1/1 for v8_7 test... 09:03:08 INFO - TEST-INFO | started process 2274 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYC4u2e/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:10 INFO - PROCESS | 2274 | 09:03:10 INFO - PROCESS | 2274 | (process:2408): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:03:20 INFO - PROCESS | 2274 | RSS: Main: 150724608 09:03:20 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | Cycle 1(1): loaded http://localhost:52889/tests/v8_7/run.html (next: http://localhost:52889/tests/v8_7/run.html) 09:03:43 INFO - PROCESS | 2274 | RSS: Main: 150867968 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | __start_tp_report 09:03:43 INFO - PROCESS | 2274 | _x_x_mozilla_page_load 09:03:43 INFO - PROCESS | 2274 | _x_x_mozilla_page_load_details 09:03:43 INFO - PROCESS | 2274 | |i|pagename|runs| 09:03:43 INFO - PROCESS | 2274 | |0;Richards;167.6727028839705 09:03:43 INFO - PROCESS | 2274 | |1;DeltaBlue;187.5468867216804 09:03:43 INFO - PROCESS | 2274 | |2;Encrypt;280.74115665356544 09:03:43 INFO - PROCESS | 2274 | |3;Decrypt;5196.891191709845 09:03:43 INFO - PROCESS | 2274 | |4;RayTrace;1074.1138560687432 09:03:43 INFO - PROCESS | 2274 | |5;Earley;685.4009595613434 09:03:43 INFO - PROCESS | 2274 | |6;Boyer;12243.90243902439 09:03:43 INFO - PROCESS | 2274 | |7;RegExp;42104.166666666664 09:03:43 INFO - PROCESS | 2274 | |8;Splay;582.0721769499418 09:03:43 INFO - PROCESS | 2274 | |9;NavierStokes;4835.748792270531 09:03:43 INFO - PROCESS | 2274 | __end_tp_report 09:03:43 INFO - PROCESS | 2274 | __startTimestamp1453741423279__endTimestamp 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | ------- Summary: start ------- 09:03:43 INFO - PROCESS | 2274 | Number of tests: 10 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | [#0] Richards Cycles:1 Average:167.67 Median:167.67 stddev:0.00 (0.0%) 09:03:43 INFO - PROCESS | 2274 | Values: 167.7 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | [#1] DeltaBlue Cycles:1 Average:187.55 Median:187.55 stddev:0.00 (0.0%) 09:03:43 INFO - PROCESS | 2274 | Values: 187.5 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 09:03:43 INFO - PROCESS | 2274 | Values: 280.7 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 09:03:43 INFO - PROCESS | 2274 | Values: 5196.9 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 09:03:43 INFO - PROCESS | 2274 | Values: 1074.1 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | [#5] Earley Cycles:1 Average:685.40 Median:685.40 stddev:0.00 (0.0%) 09:03:43 INFO - PROCESS | 2274 | Values: 685.4 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 09:03:43 INFO - PROCESS | 2274 | Values: 12243.9 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | [#7] RegExp Cycles:1 Average:42104.17 Median:42104.17 stddev:0.00 (0.0%) 09:03:43 INFO - PROCESS | 2274 | Values: 42104.2 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | [#8] Splay Cycles:1 Average:582.07 Median:582.07 stddev:0.00 (0.0%) 09:03:43 INFO - PROCESS | 2274 | Values: 582.1 09:03:43 INFO - PROCESS | 2274 | 09:03:43 INFO - PROCESS | 2274 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 09:03:43 INFO - PROCESS | 2274 | Values: 4835.7 09:03:43 INFO - PROCESS | 2274 | -------- Summary: end -------- 09:03:43 INFO - PROCESS | 2274 | 09:03:44 INFO - TEST-INFO | 2274: exit 0 09:03:44 INFO - TEST-OK | v8_7 | took 40668ms 09:03:44 INFO - SUITE-END | took 1210s 09:03:44 INFO - Completed test suite (00:20:11) 09:03:44 INFO - Working with test: dromaeo_css 09:03:44 INFO - Generating results file: dromaeo_css 09:03:44 INFO - Working with test: kraken 09:03:44 INFO - Generating results file: kraken 09:03:44 INFO - javascript benchmark 09:03:44 INFO - Working with test: v8_7 09:03:44 INFO - Generating results file: v8_7 09:03:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:03:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 09:03:44 INFO - process_Request line: dromaeo_css 6810.67 graph.html#tests=[[72,1,43]] 09:03:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:03:44 INFO - process_Request line: kraken 1513.00 graph.html#tests=[[232,1,43]] 09:03:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:03:44 INFO - process_Request line: v8_7 20469.58 graph.html#tests=[[230,1,43]] 09:03:44 INFO - RETURN: dromaeo_css: 6810.67 09:03:44 INFO - RETURN: kraken: 1513.00 09:03:44 INFO - RETURN: v8_7: 20469.58 09:03:44 INFO - javascript benchmark 09:03:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3216.0, 3236.9190770230744, 3255.8372081395955, 3275.148461400036, 3290.588676415448, 5233.555147812441, 5262.6842389456615, 5289.735513224343, 5320.334958130234, 5320.4679532046775, 5227.137522308824, 5254.973725131378, 5317.229001794737, 5333.626646134772, 5352.2506849041065, 4841.540053694902, 4904.975475122619, 4943.950560494385, 4994.850154495371, 5043.268726034723, 626.9259709078879, 4861.0, 4865.099956508039, 4935.185694360426, 4949.331840201581, 4974.253861920704, 4981.900361992776, 4993.925091123618, 5003.524665156804, 5050.74746262689, 5002.699838009731, 5005.524475174852, 5011.674241174312, 5013.799448022075, 5082.593392528589, 4794.400699912511, 4815.085133824562, 4860.295257187723, 4909.0, 5013.849584512471, 5162.070827251093, 5163.199704045879, 5187.481251874782, 5193.63644544882, 5198.662086964335, 5712.0, 5715.828525144252, 5717.113847353667, 5725.885482290372, 5745.138229265602, 5722.885542289131, 5743.396943320933, 5766.0, 5779.9422005779825, 5840.094785308284, 5435.782568697247, 5454.427285135083, 5456.48163424474, 5464.12573988164, 5475.5072043515875, 5690.658560486384, 5891.617044892068, 5918.082697181943, 5921.111833225051, 5921.792737254175, 5596.244506991586, 5675.3757086720425, 5713.028785106542, 5726.169705392695, 5765.682887441231, 5673.375928647845, 5757.510611598061, 5757.596968212185, 5759.481646651821, 5775.393583673737, 5568.053430916754, 5667.4332566743, 5720.256366672306, 5731.083026715789, 5741.942580574224, 5650.63270887391, 5651.660900345993, 5711.343195532567, 5715.714214289352, 5748.48263656273, 4360.324149756792, 4419.337099435046, 4423.823047078081, 4433.467983841895, 4437.955620443754, 3890.708196885245, 3966.920661586752, 3967.2263908537557, 3979.4030895365927, 3981.6814654827544, 5385.865353366197, 5406.567474602022, 5409.864753381118, 5446.891062178814, 5470.671759694352, 5684.488396044293, 5693.800716974886, 5699.829005129853, 5736.483716465538, 5738.799142030009, 5380.192971054373, 5386.407495175527, 5389.487998640123, 5434.456554344613, 5470.53500452466, 4859.2954021666665, 4906.8773280668265, 4913.508649135058, 4928.778204980785, 4965.106280869478, 5896.970515147483, 5963.224780778558, 5972.671503067286, 5979.9402005980255, 5992.34084250732, 5601.943980560305, 5652.491275785199, 5673.659580425187, 5742.363719469756, 5781.364049954417, 5901.203337549376, 5950.702464876826, 5970.373110823301, 5973.910391344047, 5974.850628734316, 5623.465770751772, 5626.959012582685, 5634.295713035871, 5635.154726791015, 5645.68948707825, 5592.049351610317, 5674.347450043133, 5702.144678298288, 5704.600677952503, 5721.313442386941, 5581.302337207849, 5619.606627536034, 5634.85912852182, 5638.23883775685, 5704.1443783432815, 5537.0, 5556.055470570093, 5568.16477528374, 5584.497395234448, 5593.356763972195, 5406.918616276682, 5432.34811822568, 5436.592255580768, 5505.064139096283, 5507.972460137674, 5594.664320140641, 5633.943660563506, 5667.093265077568, 5671.574631902541, 5696.373398926032, 5508.008558459515, 5515.779368825202, 5526.751296191601, 5531.170324451365, 5541.778328866801], "unit": "score", "name": "dojo.html", "value": 5266.413184739361}, {"lowerIsBetter": false, "replicates": [515.2374485761073, 525.9053370393327, 547.1000204663328, 562.2943206276123, 570.7346084070907, 27728.861355693218, 34513.30973380534, 34919.12702182447, 34964.30071398571, 34984.30031399371, 38039.42940855889, 38288.0, 38456.42315365265, 38716.41925371122, 38868.0, 8491.320694344453, 8613.095624959384, 8677.652893884237, 8685.305175585938, 8695.869561956575, 8292.917070829275, 8392.958035209815, 8420.24217820396, 8445.1977062179, 8476.915230847706, 8435.40952133351, 8460.830783384328, 8479.872801907977, 8481.74554763355, 8506.064332923374, 8421.70524031659, 8485.0666426693, 8501.574921253943, 8619.353548483889, 8662.566871656454, 8450.577471126418, 8598.828023439559, 8627.525486098262, 8645.870311945326, 8698.869516957251, 37974.0, 38265.23469530594, 38300.23399532022, 38357.23285534301, 38454.0, 3107.813531188136, 3181.6341120771176, 3198.5202219667003, 3287.572615559962, 3349.2129349602824, 28700.712992870223, 28734.568981465294, 28859.0, 29029.0, 29347.70652293471, 3454.4127498325347, 3493.637266795482, 3571.089372210096, 3614.4397618369194, 3719.628037196259, 263054.0, 263218.0, 263459.0, 266462.9999999981, 266726.0, 50490.0, 51424.48575514272, 56169.0, 56397.0, 56682.716586416806, 59930.40069599248, 60341.396586034454, 60442.39557604368, 60490.39509604935, 60803.39196607978, 11984.101192410604, 12021.338826364634, 12032.27806331623, 12056.939715301367, 12136.939315303367, 9120.49837258957, 9122.771930701652, 9170.266378689688, 9178.036306187887, 9211.078892110736, 18067.367642132464, 18334.449966501026, 18454.630907381776, 19000.04999750007, 19117.0, 7267.927320726831, 7520.360769334558, 7554.848903022019, 7577.696892124363, 7583.810404739926, 914.794171311463, 956.3114557518576, 970.5098925042809, 979.2606582030663, 1119.311623351633, 24887.0, 25075.37311567189, 25317.240482785546, 28461.146165615064, 28898.85550572234, 992.34009383759, 1013.807376598444, 1022.2946167144646, 1087.043242380723, 1104.3539529375246, 13387.866121338857, 13664.248466334247, 13671.248081355421, 13777.173369597856, 13848.0, 340785.0, 342709.0, 344041.0, 345620.0, 347217.0, 49965.0, 50094.74952625286, 50493.74753126211, 50640.74679626578, 50707.0, 1315.6316231455207, 1317.5059352742721, 1318.3803612302202, 1333.2600955752835, 1335.3723749837754, 27042.729572704022, 28052.298692532033, 28182.29544261328, 28554.85722571374, 30940.22649433782, 47169.528304716514, 48633.270500941806, 48890.0, 48891.5110848887, 49109.2633610489, 200361.0, 200744.0, 202019.0, 202208.0, 203108.0, 28696.282592935342, 31452.213694657818, 31524.0, 32115.518267225543, 32355.838220808746, 36766.264674705824, 36814.079648009014, 36912.44631330478, 37098.258034839695, 37256.25487490181, 31609.841950790098, 34061.31877362389, 34382.312353752284, 34600.307993840484, 34959.825200873835, 34446.48330275098, 34756.131096722784, 35154.64845351616, 36075.27849442944, 36185.9241964436, 32245.51631725573, 34887.30225395427, 35576.64423355733, 35687.0, 35772.28455430929, 27017.72982270231, 29633.407331853672, 31565.210869728442, 32862.507062394565, 33250.833745831114, 22938.655920160876, 24152.63771043471, 24435.04159187727, 24475.0, 24488.265352039467], "unit": "score", "name": "ext.html", "value": 17408.159417226463}, {"lowerIsBetter": false, "replicates": [359.1129909124463, 363.8380920490382, 365.29133481046773, 367.81057755256046, 370.6534390345029, 11096.278741881772, 11654.533818647265, 15545.222738863054, 16498.0, 17405.47783566495, 16814.411495597655, 16816.663666726658, 17714.822851771478, 17719.291228350852, 17750.911245443756, 5533.3083364579325, 5815.360310365856, 5822.563307751914, 5839.824805255828, 5842.32813226478, 5609.57928155388, 6084.452399284063, 6129.754809807602, 6153.692315384235, 6168.105624684418, 5932.08052751822, 6156.0, 6161.383861613847, 6181.690915454232, 6429.646369449679, 6349.333320001402, 6357.523185761086, 6380.680965951707, 6448.742050318028, 6728.730850765964, 6229.190205273331, 6437.227532696106, 6453.322401147859, 6453.612783233021, 6465.159529261213, 19895.50261243466, 20505.4873628159, 20764.68852967207, 20858.5828283435, 20883.0, 2115.3442432845713, 2225.265662331427, 2294.2887704811396, 2369.0, 2475.084218839023, 13436.596902092855, 13789.793153102712, 13872.653183670389, 14181.43274269028, 14185.0, 1891.3947536788232, 1928.6046360496064, 1975.5357490989607, 2009.6181725472259, 2010.1155491583656, 60847.391526085055, 61581.692091539706, 63042.36957630457, 63649.68175159094, 64131.0, 14864.777028344584, 14920.477783277533, 14923.403063877324, 14934.32795524204, 14971.101733896001, 22937.0, 23079.0, 23229.18697845601, 23380.883095584413, 23486.295411137693, 7538.434617403716, 7549.6225188740345, 7582.696692132363, 7655.425843061793, 7655.885161722578, 6192.845178870564, 6284.748610055638, 6292.528060395489, 6413.29453760086, 6498.0, 7397.297256760599, 7421.8144546386775, 7469.253074692488, 7478.401727861758, 7676.53940763556, 1775.5028591994262, 1878.0891267735137, 2918.9124326270244, 3094.133642580081, 3163.6519982801874, 440.99118017639466, 450.2211174667843, 886.9822603548022, 927.8051609162152, 957.5834511987168, 10133.18934485254, 10282.948585257025, 10646.095081918123, 11026.393548354918, 11083.947025032609, 447.9595442758267, 452.181551391975, 459.3293791065082, 462.89584843410637, 480.29156993434407, 5700.9429905701245, 5904.793332233351, 5939.4357536034, 5957.344692083867, 5989.251343582052, 516918.0, 544098.0, 544547.0, 553458.0, 578020.0, 72156.0, 72202.0, 72575.63712181406, 72669.0, 72706.81879543622, 464.3406362964598, 467.26172647217993, 468.44021394434003, 470.55297467406103, 471.0907947661047, 9778.60885564598, 9876.555555000186, 9878.950605246928, 10048.497575121068, 10080.54637541327, 29987.250318742204, 30582.847085764428, 31408.0, 31566.526502102028, 32106.678933211304, 42029.0, 42551.7872410636, 43844.56155438405, 43929.56070439383, 44337.33493997657, 7253.56478611285, 7425.851482970203, 7455.888161677688, 7459.962700186465, 7582.62086895664, 7728.806779830325, 7912.36701063925, 10779.0, 11001.559937602406, 11036.558537658404, 7311.122665279988, 7360.77917662471, 7420.072490938633, 7473.580019796222, 7769.805754856174, 7511.849763004819, 7708.537487750753, 7766.805829854073, 7826.804329891798, 7846.0, 7433.450026430453, 7739.690412383667, 7760.188683016566, 7793.64928578204, 7973.9202607973175, 8548.145185481402, 8890.64437422496, 8929.973053098976, 9083.182513573545, 9794.510274486389, 3103.6120484939383, 3793.355129628025, 6398.552101353047, 10015.449150296803, 10318.896811032095], "unit": "score", "name": "jquery.html", "value": 7913.240936866422}, {"lowerIsBetter": false, "replicates": [1418.0711633879807, 1426.3438818143654, 1578.3686525389842, 1739.7999230088544, 1777.2535535075267, 7895.960520197398, 7943.086545047321, 8000.239977202171, 8026.598670066495, 8072.878906816402, 8059.91940080599, 8100.594970251494, 8107.878381824277, 8185.140560241178, 8195.549244791535, 2335.404471859678, 2349.835511514195, 2350.9412264693347, 2360.126753101355, 2360.36270207044, 2294.128231272123, 2311.0409180190286, 2325.813934885205, 2342.02805835578, 2353.846999944998, 2324.372419446748, 2337.8363514553903, 2338.555674421863, 2358.622620380731, 2388.7850093491584, 2257.221258665758, 2300.1259521381853, 2309.93070207894, 2310.8266879984067, 2316.0504193280676, 2382.0948039744785, 2409.2531315292317, 2421.794147497465, 2426.1993542131054, 2431.9148829790875, 7994.440389172761, 8053.275205231499, 8054.9597252013955, 8058.597070146469, 8066.628673125583, 4618.9076218475775, 4640.280756482751, 4676.625869930397, 4712.175369310357, 4716.740579268139, 2937.574051762504, 2944.1020488750924, 2946.8673909674117, 2960.881564737408, 2982.120274519022, 874.9606267717904, 899.3929097858985, 908.4140729229609, 937.8686983822271, 939.4410325856105, 11262.324260544394, 11346.48940797666, 11353.069978103742, 11369.431528423464, 11371.772564548746, 4061.6750659947133, 4153.979230103831, 4237.025484138665, 4240.257954857949, 4246.320588705792, 9104.8634270486, 9128.087191280818, 9138.588763505659, 9144.131307525775, 9175.862362064574, 4579.267317229227, 4584.1977653910435, 4629.930551041737, 4642.048380082075, 4648.5119062498625, 4212.810423530948, 4229.61933425987, 4234.915301693949, 4239.38528913312, 4247.341662042389, 3506.7194624429985, 3526.2947410518, 3557.2707594942976, 3566.2510872716502, 3586.7130629549574, 1085.3270971997254, 1110.0786347331696, 1119.1494464207099, 1121.4280716834473, 1123.5955056179769, 933.8412469880137, 942.8962814090445, 1118.9873164785881, 1130.513879032024, 1232.975340493203, 7330.486865919334, 7394.334509894028, 7418.814529636695, 7431.2197219292275, 7457.32884040439, 1193.2482536002262, 1196.6170825335982, 1220.4324988880214, 1229.4590380232669, 1237.0351126121639, 5831.4168583141345, 5898.616589921641, 5919.319278283053, 5928.584999050111, 5934.258217722785, 9253.491057991874, 9952.80094398108, 9960.501974901372, 10035.79928401428, 10065.798684026426, 9856.950715246378, 9862.753431164136, 9882.308238423242, 9938.950305248572, 9976.401415915068, 7422.255769894071, 7605.543667379975, 7688.769336919901, 7713.4214933880185, 7791.649375778104, 7327.963360183165, 7351.889721654286, 7400.074990626172, 7401.1488678802625, 7432.925670743223, 8518.957405212934, 8785.868211976698, 8826.602802873758, 8879.866801998105, 8903.065178156201, 8727.825443491221, 8793.0, 8877.955610221907, 8937.374383793072, 9038.051004644418, 7198.8920166198595, 7276.0, 7278.126624805057, 7306.890396643948, 7338.926610733824, 7718.112417071884, 7812.960935195288, 7832.0, 7883.487573307717, 7910.9604451977375, 7192.280771922766, 7469.663865125974, 7491.962540187482, 7524.962375188089, 7592.620368981639, 7165.319294666998, 7236.552689462023, 7245.529040612343, 7304.926950730637, 7314.122305323395, 7146.499745017799, 7153.213146553979, 7182.96408517954, 7184.533005354635, 7211.0, 6565.146530950946, 6596.571222870498, 6604.471642268511, 6631.1379520662, 6685.39831415175, 6546.770863019771, 6618.569792963442, 6688.464922806066, 6690.765823196165, 6709.161354830646], "unit": "score", "name": "mootools.html", "value": 4575.068474627201}, {"lowerIsBetter": false, "replicates": [325.07678193929235, 326.905197492727, 335.6358351188959, 336.79792124725185, 340.96078950920634, 6143.723532441039, 6213.130161777349, 6253.874922501547, 6357.173567436238, 6357.205349331333, 6023.638581685102, 6187.288461826891, 6196.59722118062, 6226.564140510155, 6238.875222495547, 4744.881377965544, 4762.880927976811, 4767.618590512768, 4781.5218478152165, 4786.090642777861, 4763.85708428746, 4771.9761401192945, 4781.832635857746, 4789.353437285974, 4790.281457781326, 4639.932815452448, 4696.154692155428, 4741.407324084489, 4747.1692453820615, 4767.976160119195, 4709.317149013391, 4732.763361831895, 4736.692115012514, 4742.620590352763, 4763.0, 4135.60711732385, 4139.544650088488, 4155.127423241123, 4155.148194620096, 4157.334826427787, 5825.300963884319, 5880.147378630118, 5884.9705751470965, 5885.470307672287, 5899.764009439617, 5412.404635490093, 5424.945750542483, 5469.863253418696, 5470.7264636768, 5482.17767334899, 6515.218173819172, 6526.477881769447, 6533.346665333429, 6536.0, 6565.606063636149, 4505.662075344329, 4507.008458139204, 4523.321501774727, 4544.727316360996, 4546.181687296285, 6683.431908287801, 6853.314668533157, 6876.762182807092, 6921.826954326182, 6929.203141638776, 4459.732416055047, 4462.620677242471, 4486.910261794811, 4492.775361231926, 4494.303382975644, 4519.774011299488, 4556.7721613919175, 4557.361969324297, 4562.749048802348, 4581.65637577183, 5310.044192045469, 5313.203019547099, 5315.0, 5315.654482458628, 5319.0957537218765, 6410.0, 6467.094606755058, 6485.70814313357, 6533.216014078246, 6570.408663220333, 1599.8160211575819, 1604.8555629993357, 1640.409452597064, 1648.4477699970644, 1650.414102993444, 1056.3556230699267, 1058.4760543531002, 1069.6256310291335, 1075.4568942683895, 1082.4533610526635, 6177.938220617826, 6218.1916350875, 6238.844028899223, 6274.0, 6281.2462504498835, 6655.534112612071, 6696.732130714814, 6739.427148692318, 6747.730090796412, 6795.354441328066, 6102.267727872595, 6216.0, 6231.813045608639, 6240.095186198067, 6260.937390626035, 3685.9078523037138, 3704.6665800077585, 3705.0, 3708.9258214835554, 3710.18375957289, 7149.642517874086, 7150.855863061989, 7153.642317884189, 7156.713731450788, 7158.8210294742, 6679.899801502981, 6921.8961715574305, 6930.272321406281, 6943.756968506179, 6950.687219075154, 7079.1505019398, 7083.397911177504, 7105.964470177616, 7141.9642901785155, 7145.499815013003, 6716.899246511404, 6722.092517510074, 6725.9663701681175, 6739.764108256188, 6783.559068660521, 6561.507886908405, 6658.766943156967, 6671.933280667326, 6711.194656641234, 6716.194056713226, 7061.293870612898, 7098.432125430057, 7104.573725576482, 7107.0, 7132.251113632994, 4513.074819661896, 4557.339185818104, 4574.496805351475, 4578.725276483422, 4579.542045795394, 6672.132622759011, 6741.325867413219, 6753.3246675332075, 6753.649270145892, 6955.443564514725, 6719.294474080151, 6727.562708423937, 6746.4940129489505, 6768.255491895789, 6783.660816959034, 6692.531522793358, 6700.564463309869, 6704.061431399706, 6714.026466162281, 6722.899156512754, 6413.551051426542, 6521.836954076186, 6526.086347911391, 6550.410463058157, 6634.933650663432, 6755.93244067553, 6759.5606285591275, 6764.4588432924265, 6837.589744615339, 6838.281980392187, 6549.115869357766, 6572.8356791080605, 6608.768693095719, 6615.966920165561, 6628.966855165693], "unit": "score", "name": "prototype.html", "value": 4942.24440854186}, {"lowerIsBetter": false, "replicates": [701.0115736811094, 714.8606021825746, 738.7968308715105, 774.5159275452842, 867.4014929698508, 14349.210793406359, 14350.497732579362, 14356.066855654375, 14391.280435978186, 14400.71198576028, 13016.544420945245, 13072.673183170426, 13086.93456532716, 13101.606951791438, 13106.344682765872, 661.8345413646589, 794.086800179795, 797.4139007829241, 798.480987358219, 800.5997001499251, 662.8276648071512, 791.6754130806371, 798.4131663227552, 801.3989507869098, 801.8596745569502, 821.6015232612178, 823.3660081737058, 828.225609055532, 828.4821986258588, 832.1013305629936, 818.2267756969666, 818.639798488669, 821.9807438775935, 825.3273582030656, 826.921442462965, 605.5882000239835, 607.9544034197453, 608.7930103764742, 609.2171559546007, 609.881073190728, 12495.625131246077, 12598.307093109875, 12618.432170552347, 12636.05229607774, 12653.936730316289, 11494.770104597945, 11545.30728156305, 11575.610926688767, 11746.353950532717, 11883.87967298994, 9838.458884761336, 9862.112409883144, 9888.802223955481, 9891.35706179096, 10022.298439109265, 3284.5894263217097, 3329.6170940341926, 3374.7806392584403, 3412.1640198151363, 3440.3291358185165, 45223.321650175276, 45927.31109033367, 46101.0, 46243.768781156214, 46255.0, 9280.535973201448, 9281.21109705669, 9325.580348884316, 9359.0, 9501.762455938519, 16531.256093475822, 16652.16739163037, 16673.0, 16896.831031689773, 16967.236474358684, 6514.771982980573, 6594.538382313192, 6603.0, 6734.494912881553, 6822.658867056627, 3943.1719338939142, 4022.2960981828064, 4023.4970628671417, 4035.3139966205817, 4126.051008268115, 2953.1731115287753, 2985.11938978002, 2987.8207307561615, 2988.1483777123417, 3004.1137864330076, 562.0922210629885, 565.7934853778341, 582.8076734677546, 589.3664310865751, 589.4135335341277, 588.9499392551681, 641.8299150725062, 647.4043879630657, 680.7038938061959, 716.5020310883885, 8158.796030099295, 8337.833243335099, 8337.95831020853, 8339.791505212419, 8346.666133354598, 560.9971950140223, 568.3747877334981, 699.4928676709446, 713.5718568858747, 725.7351066860558, 3798.6201379862346, 3897.707671924617, 4142.5857414258935, 4158.750474971512, 4229.577042295746, 55513.722431387585, 55727.164092538645, 55838.441615583324, 56195.71902140463, 56212.71893640587, 48318.0, 48939.51060489421, 49320.75339623351, 49611.751941240065, 49636.50363496391, 43996.0, 44026.11947761027, 44475.55524444714, 44667.553324466986, 45269.32096018562, 8153.714619988272, 8230.83538329242, 8247.21651443112, 8421.578921054046, 8503.957480212559, 31954.520682189323, 32309.838450807594, 32539.186520336232, 33337.666623333454, 34066.65933340734, 42276.0, 42551.36172957346, 42569.787151065284, 42647.36028959506, 42789.0, 10604.628837990942, 10665.626703065356, 10799.622013229498, 10867.673969780919, 10926.344419334548, 11577.305361678325, 11588.246763960316, 11730.002949749025, 11785.292882427082, 12032.458539365925, 10826.729331766768, 11108.277961932448, 11241.269317494336, 11352.148588856035, 11693.707657308636, 10709.0, 10752.40861752611, 11138.610148644759, 11147.219694621299, 11472.12949112929, 9970.215233347057, 10444.112250458797, 10876.12990960737, 10923.344599324066, 10965.177611678997, 9061.0, 9147.496887670975, 9186.58660360272, 9312.906870931203, 9415.858762118436, 9001.684941027033, 9018.954905225432, 9487.857682134912, 9602.32783705134, 9649.179819715122], "unit": "score", "name": "yui.html", "value": 6083.621232255146}], "name": "dromaeo_css", "value": 6810.672624313777}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 113.0, 112.0, 114.0, 124.0, 111.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 150.0, 169.0, 130.0, 152.0, 155.0, 131.0, 175.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 164.0, 174.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 74.0, 77.0, 73.0, 130.0, 76.0, 77.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 143.0, 97.0, 97.0, 98.0, 147.0, 98.0, 98.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 111.3}, {"lowerIsBetter": true, "replicates": [110.0, 114.0, 114.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 68.0, 60.0, 62.0, 59.0, 63.0, 68.0, 73.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 63.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 70.0, 67.0, 68.0, 67.0, 67.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [85.0, 81.0, 84.0, 90.0, 90.0, 83.0, 84.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [120.0, 128.0, 111.0, 116.0, 123.0, 122.0, 119.0, 129.0, 121.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [130.0, 132.0, 147.0, 141.0, 144.0, 131.0, 142.0, 151.0, 139.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.9}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1513.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.6727028839705], "unit": "score", "name": "Richards", "value": 210.54112800000007}, {"lowerIsBetter": false, "replicates": [187.5468867216804], "unit": "score", "name": "DeltaBlue", "value": 352.54117599999995}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [685.4009595613434], "unit": "score", "name": "Earley", "value": 972.3695169999999}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [42104.166666666664], "unit": "score", "name": "RegExp", "value": 21.63645719940624}, {"lowerIsBetter": false, "replicates": [582.0721769499418], "unit": "score", "name": "Splay", "value": 140.001538}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20469.582748402074}]} 09:03:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20469.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1513.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6810.67"}}} 09:03:44 INFO - Return code: 0 09:03:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:03:44 INFO - # TBPL SUCCESS # 09:03:44 INFO - Running post-action listener: _resource_record_post_action 09:03:44 INFO - Running post-run listener: _resource_record_post_run 09:03:45 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 24576; Write bytes: 551321600; Read time: 168; Write time: 610396 09:03:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236335104; Read time: 0; Write time: 308876 09:03:45 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 24576; Write bytes: 314982400; Read time: 168; Write time: 301520 09:03:45 INFO - Running post-run listener: _upload_blobber_files 09:03:45 INFO - Blob upload gear active. 09:03:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:03:45 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:03:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:03:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:03:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:03:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:46 INFO - (blobuploader) - INFO - Done attempting. 09:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:03:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:48 INFO - (blobuploader) - INFO - Done attempting. 09:03:48 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:48 INFO - Return code: 0 09:03:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:03:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98cbffee50ee2a9ea9bd7c09b58488421dd96828be9cf312d3531c970fe64524020620bf2d949a2b0855ccf0c7b24b572cfd385f788367b91d3deed29b4c8c3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1f6739d9bcddcb6d53d114ce48dcce37815f00b8b02c67f6fb6dd4b247929a84e8c3dbcc67287c3dd89918ce6dbe9aaef79112dd1e8432010359aa639ec1643"} 09:03:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:03:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:03:48 INFO - Contents: 09:03:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98cbffee50ee2a9ea9bd7c09b58488421dd96828be9cf312d3531c970fe64524020620bf2d949a2b0855ccf0c7b24b572cfd385f788367b91d3deed29b4c8c3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1f6739d9bcddcb6d53d114ce48dcce37815f00b8b02c67f6fb6dd4b247929a84e8c3dbcc67287c3dd89918ce6dbe9aaef79112dd1e8432010359aa639ec1643"} 09:03:48 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:48 INFO - Copying logs to upload dir... 09:03:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:03:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.369973 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-25 09:03:48.086774) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 09:03:48.089880) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559 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/98cbffee50ee2a9ea9bd7c09b58488421dd96828be9cf312d3531c970fe64524020620bf2d949a2b0855ccf0c7b24b572cfd385f788367b91d3deed29b4c8c3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1f6739d9bcddcb6d53d114ce48dcce37815f00b8b02c67f6fb6dd4b247929a84e8c3dbcc67287c3dd89918ce6dbe9aaef79112dd1e8432010359aa639ec1643"} build_url:https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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/98cbffee50ee2a9ea9bd7c09b58488421dd96828be9cf312d3531c970fe64524020620bf2d949a2b0855ccf0c7b24b572cfd385f788367b91d3deed29b4c8c3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1f6739d9bcddcb6d53d114ce48dcce37815f00b8b02c67f6fb6dd4b247929a84e8c3dbcc67287c3dd89918ce6dbe9aaef79112dd1e8432010359aa639ec1643"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 09:03:48.119529) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:03:48.119930) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453740156.498893-38876559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:03:48.200381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 09:03:48.200850) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 09:03:48.201168) ========= ========= Total master_lag: 0.28 =========