builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1453739952.48 results: success (0) buildid: 20160125030203 builduid: fa9411aaf741499a9b7142874c71568d revision: 67c66c2878aed17ae3096d7db483ddbb2293c503 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.479872) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.480235) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.480539) ========= 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=82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006322 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.507377) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.507678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.520940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.521202) ========= 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=82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.571770) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.572058) ========= 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:39:12.572418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.572718) ========= 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=82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 08:39:12-- 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% 37.5M=0s 2016-01-25 08:39:12 (37.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166290 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.751522) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.751847) ========= 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=82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014370 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:12.801547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 08:39:12.801898) ========= 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=82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 08:39:13,038 truncating revision to first 12 chars 2016-01-25 08:39:13,039 Setting DEBUG logging. 2016-01-25 08:39:13,039 attempt 1/10 2016-01-25 08:39:13,039 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:39:14,323 unpacking tar archive at: mozilla-central-67c66c2878ae/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581562 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 08:39:14.397099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:14.397451) ========= 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=82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 67c66c2878aed17ae3096d7db483ddbb2293c503 program finished with exit code 0 elapsedTime=0.003847 script_repo_revision: '67c66c2878aed17ae3096d7db483ddbb2293c503' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:14.447294) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:14.447612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 08:39:14.457162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-25 08:39:14.457433) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:39:14 INFO - MultiFileLogger online at 20160125 08:39:14 in /builds/slave/test-pgo 08:39:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:39:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:39:14 INFO - {'append_to_log': False, 08:39:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:39:14 INFO - 'blob_upload_branch': 'Firefox', 08:39:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:39:14 INFO - 'branch': 'Firefox', 08:39:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:39:14 INFO - 'config_files': ('talos/linux_config.py',), 08:39:14 INFO - 'default_actions': ('clobber', 08:39:14 INFO - 'read-buildbot-config', 08:39:14 INFO - 'download-and-extract', 08:39:14 INFO - 'populate-webroot', 08:39:14 INFO - 'create-virtualenv', 08:39:14 INFO - 'install', 08:39:14 INFO - 'run-tests'), 08:39:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:39:14 INFO - 'download_minidump_stackwalk': True, 08:39:14 INFO - 'download_symbols': 'ondemand', 08:39:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:39:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:39:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:39:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:39:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:39:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:39:14 INFO - 'installer_path': 'installer.exe', 08:39:14 INFO - 'log_level': 'info', 08:39:14 INFO - 'log_name': 'talos', 08:39:14 INFO - 'log_to_console': True, 08:39:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:39:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:39:14 INFO - 'opt_config_files': (), 08:39:14 INFO - 'pip_index': False, 08:39:14 INFO - 'sps_profile': False, 08:39:14 INFO - 'sps_profile_interval': 0, 08:39:14 INFO - 'suite': 'dromaeojs', 08:39:14 INFO - 'system_bits': '32', 08:39:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:39:14 INFO - 'title': 'talos-linux64-ix-055', 08:39:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:39:14 INFO - 'use_talos_json': True, 08:39:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:39:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:39:14 INFO - 'work_dir': 'build'} 08:39:14 INFO - ##### 08:39:14 INFO - ##### Running clobber step. 08:39:14 INFO - ##### 08:39:14 INFO - Running pre-action listener: _resource_record_pre_action 08:39:14 INFO - Running main action method: clobber 08:39:14 INFO - rmtree: /builds/slave/test-pgo/build 08:39:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:39:15 INFO - Running post-action listener: _resource_record_post_action 08:39:15 INFO - ##### 08:39:15 INFO - ##### Running read-buildbot-config step. 08:39:15 INFO - ##### 08:39:15 INFO - Running pre-action listener: _resource_record_pre_action 08:39:15 INFO - Running main action method: read_buildbot_config 08:39:15 INFO - Using buildbot properties: 08:39:15 INFO - { 08:39:15 INFO - "project": "", 08:39:15 INFO - "product": "firefox", 08:39:15 INFO - "script_repo_revision": "production", 08:39:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:39:15 INFO - "repository": "", 08:39:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 08:39:15 INFO - "buildid": "20160125030203", 08:39:15 INFO - "stage_platform": "linux64-pgo", 08:39:15 INFO - "basedir": "/builds/slave/test-pgo", 08:39:15 INFO - "nightly_build": "True", 08:39:15 INFO - "buildnumber": 325, 08:39:15 INFO - "slavename": "talos-linux64-ix-055", 08:39:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:39:15 INFO - "platform": "ubuntu64_hw", 08:39:15 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 08:39:15 INFO - "branch": "mozilla-central", 08:39:15 INFO - "repo_path": "mozilla-central", 08:39:15 INFO - "revision": "67c66c2878aed17ae3096d7db483ddbb2293c503", 08:39:15 INFO - "pgo_build": "True", 08:39:15 INFO - "builduid": "fa9411aaf741499a9b7142874c71568d", 08:39:15 INFO - "slavebuilddir": "test" 08:39:15 INFO - } 08:39:15 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:39:15 INFO - Running post-action listener: _resource_record_post_action 08:39:15 INFO - ##### 08:39:15 INFO - ##### Running download-and-extract step. 08:39:15 INFO - ##### 08:39:15 INFO - Running pre-action listener: _resource_record_pre_action 08:39:15 INFO - Running main action method: download_and_extract 08:39:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:39:15 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:39:15 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:39:15 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:39:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json 08:39:15 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:39:15 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:39:15 INFO - Downloaded 1448 bytes. 08:39:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:39:15 INFO - Using the following test package requirements: 08:39:15 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:39:15 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:39:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:39:15 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:39:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:39:15 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:39:15 INFO - u'jsshell-linux-x86_64.zip'], 08:39:15 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:39:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:39:15 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:39:15 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:39:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:39:15 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:39:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:39:15 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:39:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:39:15 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:39:15 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:39:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:39:15 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:39:15 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:39:15 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:39:15 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:39:15 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:39:15 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:39:15 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:39:17 INFO - Downloaded 22494448 bytes. 08:39:17 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:39:17 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:39:18 INFO - Return code: 0 08:39:18 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:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:18 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:39:18 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:39:18 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:39:18 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:39:18 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:39:19 INFO - Downloaded 22494448 bytes. 08:39:19 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:39:19 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:39:21 INFO - Return code: 0 08:39:21 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:39:21 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:39:21 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:39:21 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:39:21 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:39:21 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:39:22 INFO - Downloaded 10706572 bytes. 08:39:22 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:39:22 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:39:22 INFO - Return code: 0 08:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:22 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:39:22 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:39:22 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:39:22 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:39:22 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:39:23 INFO - Downloaded 55990395 bytes. 08:39:23 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:39:23 INFO - mkdir: /builds/slave/test-pgo/properties 08:39:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:39:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:39:23 INFO - Contents: 08:39:23 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:39:23 INFO - Running post-action listener: _resource_record_post_action 08:39:23 INFO - Running post-action listener: set_extra_try_arguments 08:39:23 INFO - ##### 08:39:23 INFO - ##### Running populate-webroot step. 08:39:23 INFO - ##### 08:39:23 INFO - Running pre-action listener: _resource_record_pre_action 08:39:23 INFO - Running main action method: populate_webroot 08:39:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:39:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:39:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:39:23 INFO - '--tppagecycles', 08:39:23 INFO - '7'], 08:39:23 INFO - 'tests': ['tsvgm']}}, 08:39:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:39:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:39:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:39:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:39:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:39:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:39:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:23 INFO - 'talos_options': ['--e10s'], 08:39:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:23 INFO - 'tests': ['damp', 'tps']}, 08:39:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:23 INFO - 'talos_options': ['--e10s'], 08:39:23 INFO - 'tests': ['damp', 'tps']}, 08:39:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:39:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:39:23 INFO - 'other': {'tests': ['a11yr', 08:39:23 INFO - 'ts_paint', 08:39:23 INFO - 'tpaint', 08:39:23 INFO - 'sessionrestore', 08:39:23 INFO - 'sessionrestore_no_auto_restore']}, 08:39:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:39:23 INFO - 'tests': ['a11yr', 08:39:23 INFO - 'ts_paint', 08:39:23 INFO - 'tpaint', 08:39:23 INFO - 'sessionrestore', 08:39:23 INFO - 'sessionrestore_no_auto_restore']}, 08:39:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:39:23 INFO - 'tests': ['a11yr', 08:39:23 INFO - 'ts_paint', 08:39:23 INFO - 'tpaint', 08:39:23 INFO - 'sessionrestore', 08:39:23 INFO - 'sessionrestore_no_auto_restore']}, 08:39:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:39:23 INFO - 'tests': ['a11yr', 08:39:23 INFO - 'ts_paint', 08:39:23 INFO - 'tpaint', 08:39:23 INFO - 'sessionrestore', 08:39:23 INFO - 'sessionrestore_no_auto_restore']}, 08:39:23 INFO - 'other_l64': {'tests': ['a11yr', 08:39:23 INFO - 'ts_paint', 08:39:23 INFO - 'tpaint', 08:39:23 INFO - 'sessionrestore', 08:39:23 INFO - 'sessionrestore_no_auto_restore']}, 08:39:23 INFO - 'other_nol64': {'tests': ['a11yr', 08:39:23 INFO - 'ts_paint', 08:39:23 INFO - 'tpaint', 08:39:23 INFO - 'sessionrestore', 08:39:23 INFO - 'sessionrestore_no_auto_restore']}, 08:39:23 INFO - 'svgr': {'tests': ['tsvgx', 08:39:23 INFO - 'tsvgr_opacity', 08:39:23 INFO - 'tart', 08:39:23 INFO - 'tscrollx', 08:39:23 INFO - 'cart']}, 08:39:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:39:23 INFO - 'tests': ['tsvgx', 08:39:23 INFO - 'tsvgr_opacity', 08:39:23 INFO - 'tart', 08:39:23 INFO - 'tscrollx', 08:39:23 INFO - 'cart']}, 08:39:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:23 INFO - 'tests': ['tp5o']}, 08:39:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:23 INFO - 'talos_options': ['--e10s'], 08:39:23 INFO - 'tests': ['tp5o']}, 08:39:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:23 INFO - 'talos_options': ['--xperf_path', 08:39:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:23 INFO - 'tests': ['tp5n']}, 08:39:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:23 INFO - 'talos_options': ['--e10s', 08:39:23 INFO - '--xperf_path', 08:39:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:23 INFO - 'tests': ['tp5n']}}, 08:39:23 INFO - 'talos.zip': {'path': '', 08:39:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:39:23 INFO - Running post-action listener: _resource_record_post_action 08:39:23 INFO - ##### 08:39:23 INFO - ##### Running create-virtualenv step. 08:39:23 INFO - ##### 08:39:23 INFO - Running pre-action listener: _resource_record_pre_action 08:39:23 INFO - Running main action method: create_virtualenv 08:39:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:39:23 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:39:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:39:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:39:23 INFO - Using real prefix '/usr' 08:39:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:39:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:39:26 INFO - Installing pip.................done. 08:39:26 INFO - Return code: 0 08:39:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:39:26 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:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:26 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:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:26 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 0x7f2a8a369f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290e360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299d540>, '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 0x299e440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299e8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', '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:39:26 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:39:26 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:39:26 INFO - Using env: {'DISPLAY': ':0', 08:39:26 INFO - 'HOME': '/home/cltbld', 08:39:26 INFO - 'LANG': 'en_US.UTF-8', 08:39:26 INFO - 'LANGUAGE': 'en_US:en', 08:39:26 INFO - 'LOGNAME': 'cltbld', 08:39:26 INFO - 'MAIL': '/var/mail/cltbld', 08:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:26 INFO - 'MOZ_NO_REMOTE': '1', 08:39:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:26 INFO - 'NO_EM_RESTART': '1', 08:39:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:26 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:26 INFO - 'SHELL': '/bin/bash', 08:39:26 INFO - 'SHLVL': '1', 08:39:26 INFO - 'TERM': 'linux', 08:39:26 INFO - 'TMOUT': '86400', 08:39:26 INFO - 'USER': 'cltbld', 08:39:26 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', 08:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:26 INFO - '_': '/tools/buildbot/bin/python'} 08:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:26 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:39:26 INFO - Cleaning up... 08:39:26 INFO - Return code: 0 08:39:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:39:26 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:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:26 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:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:26 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 0x7f2a8a369f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290e360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299d540>, '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 0x299e440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299e8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', '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:39:26 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:39:26 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:39:26 INFO - Using env: {'DISPLAY': ':0', 08:39:26 INFO - 'HOME': '/home/cltbld', 08:39:26 INFO - 'LANG': 'en_US.UTF-8', 08:39:26 INFO - 'LANGUAGE': 'en_US:en', 08:39:26 INFO - 'LOGNAME': 'cltbld', 08:39:26 INFO - 'MAIL': '/var/mail/cltbld', 08:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:26 INFO - 'MOZ_NO_REMOTE': '1', 08:39:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:26 INFO - 'NO_EM_RESTART': '1', 08:39:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:26 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:26 INFO - 'SHELL': '/bin/bash', 08:39:26 INFO - 'SHLVL': '1', 08:39:26 INFO - 'TERM': 'linux', 08:39:26 INFO - 'TMOUT': '86400', 08:39:26 INFO - 'USER': 'cltbld', 08:39:26 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', 08:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:26 INFO - '_': '/tools/buildbot/bin/python'} 08:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:26 INFO - Downloading/unpacking psutil>=0.7.1 08:39:26 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:39:26 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:39:26 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:39:26 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:39:26 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:39:26 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:39:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:39:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:28 INFO - Installing collected packages: psutil 08:39:28 INFO - Running setup.py install for psutil 08:39:28 INFO - building 'psutil._psutil_linux' extension 08:39:28 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:39:28 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:39:28 INFO - building 'psutil._psutil_posix' extension 08:39:28 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:39:29 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:39:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:29 INFO - Successfully installed psutil 08:39:29 INFO - Cleaning up... 08:39:29 INFO - Return code: 0 08:39:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:39:29 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:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:29 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:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:29 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 0x7f2a8a369f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290e360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299d540>, '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 0x299e440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299e8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', '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:39:29 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:39:29 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:39:29 INFO - Using env: {'DISPLAY': ':0', 08:39:29 INFO - 'HOME': '/home/cltbld', 08:39:29 INFO - 'LANG': 'en_US.UTF-8', 08:39:29 INFO - 'LANGUAGE': 'en_US:en', 08:39:29 INFO - 'LOGNAME': 'cltbld', 08:39:29 INFO - 'MAIL': '/var/mail/cltbld', 08:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:29 INFO - 'MOZ_NO_REMOTE': '1', 08:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:29 INFO - 'NO_EM_RESTART': '1', 08:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:29 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:29 INFO - 'SHELL': '/bin/bash', 08:39:29 INFO - 'SHLVL': '1', 08:39:29 INFO - 'TERM': 'linux', 08:39:29 INFO - 'TMOUT': '86400', 08:39:29 INFO - 'USER': 'cltbld', 08:39:29 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', 08:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:29 INFO - '_': '/tools/buildbot/bin/python'} 08:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:39:29 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:39:29 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:39:29 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:39:29 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:39:29 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:39:29 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:39:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:39:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:39:31 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:39:31 INFO - Installing collected packages: mozsystemmonitor 08:39:31 INFO - Running setup.py install for mozsystemmonitor 08:39:31 INFO - Successfully installed mozsystemmonitor 08:39:31 INFO - Cleaning up... 08:39:31 INFO - Return code: 0 08:39:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:39: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:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:31 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 0x7f2a8a369f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290e360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299d540>, '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 0x299e440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299e8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', '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:39:31 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:39:31 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:39:31 INFO - Using env: {'DISPLAY': ':0', 08:39:31 INFO - 'HOME': '/home/cltbld', 08:39:31 INFO - 'LANG': 'en_US.UTF-8', 08:39:31 INFO - 'LANGUAGE': 'en_US:en', 08:39:31 INFO - 'LOGNAME': 'cltbld', 08:39:31 INFO - 'MAIL': '/var/mail/cltbld', 08:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:31 INFO - 'MOZ_NO_REMOTE': '1', 08:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:31 INFO - 'NO_EM_RESTART': '1', 08:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:31 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:31 INFO - 'SHELL': '/bin/bash', 08:39:31 INFO - 'SHLVL': '1', 08:39:31 INFO - 'TERM': 'linux', 08:39:31 INFO - 'TMOUT': '86400', 08:39:31 INFO - 'USER': 'cltbld', 08:39:31 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', 08:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:31 INFO - '_': '/tools/buildbot/bin/python'} 08:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:39:31 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:39:31 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:39:31 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:39:31 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:39:31 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:39:31 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:39:33 INFO - Downloading blobuploader-1.2.4.tar.gz 08:39:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:39:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:39:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:34 INFO - Downloading docopt-0.6.1.tar.gz 08:39:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:34 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:34 INFO - Running setup.py install for blobuploader 08:39:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:39:34 INFO - Running setup.py install for requests 08:39:34 INFO - Running setup.py install for docopt 08:39:34 INFO - Successfully installed blobuploader requests docopt 08:39:34 INFO - Cleaning up... 08:39:34 INFO - Return code: 0 08:39:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:39:34 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:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:34 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:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:34 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 0x7f2a8a369f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290e360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299d540>, '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 0x299e440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299e8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', '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:39:34 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:39:34 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:39:34 INFO - Using env: {'DISPLAY': ':0', 08:39:34 INFO - 'HOME': '/home/cltbld', 08:39:34 INFO - 'LANG': 'en_US.UTF-8', 08:39:34 INFO - 'LANGUAGE': 'en_US:en', 08:39:34 INFO - 'LOGNAME': 'cltbld', 08:39:34 INFO - 'MAIL': '/var/mail/cltbld', 08:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:34 INFO - 'MOZ_NO_REMOTE': '1', 08:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:34 INFO - 'NO_EM_RESTART': '1', 08:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:34 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:34 INFO - 'SHELL': '/bin/bash', 08:39:34 INFO - 'SHLVL': '1', 08:39:34 INFO - 'TERM': 'linux', 08:39:34 INFO - 'TMOUT': '86400', 08:39:34 INFO - 'USER': 'cltbld', 08:39:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', 08:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:34 INFO - '_': '/tools/buildbot/bin/python'} 08:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:39:34 INFO - Running setup.py (path:/tmp/pip-6NxsLK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:39:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:39:34 INFO - Running setup.py (path:/tmp/pip-nPb9Jp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:39:35 INFO - Running setup.py (path:/tmp/pip-AmK87k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:39:35 INFO - Running setup.py (path:/tmp/pip-f_iR36-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:39:35 INFO - Running setup.py (path:/tmp/pip-snZhDx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:39:35 INFO - Running setup.py (path:/tmp/pip-IOLQPJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:39:35 INFO - Running setup.py (path:/tmp/pip-Nfo3mL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:39:35 INFO - Running setup.py (path:/tmp/pip-OEYoc9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:39:35 INFO - Running setup.py (path:/tmp/pip-coXBJO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:39:35 INFO - Running setup.py (path:/tmp/pip-gnEgbp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:39:35 INFO - Running setup.py (path:/tmp/pip-UDLIJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:39:35 INFO - Running setup.py (path:/tmp/pip-_7NwyP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:39:35 INFO - Running setup.py (path:/tmp/pip-1CSt1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:39:35 INFO - Running setup.py (path:/tmp/pip-DjLO05-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:39:35 INFO - Running setup.py (path:/tmp/pip-9fIen1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:39:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:39:35 INFO - Running setup.py (path:/tmp/pip-AmAlEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:39:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:39:36 INFO - Running setup.py (path:/tmp/pip-ZFpgNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:39:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:36 INFO - Running setup.py install for manifestparser 08:39:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:39:36 INFO - Running setup.py install for mozcrash 08:39:36 INFO - Running setup.py install for mozdebug 08:39:36 INFO - Running setup.py install for mozdevice 08:39:36 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:39:36 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:39:36 INFO - Running setup.py install for mozfile 08:39:36 INFO - Running setup.py install for mozhttpd 08:39:36 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:39:36 INFO - Running setup.py install for mozinfo 08:39:36 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:39:36 INFO - Running setup.py install for mozInstall 08:39:36 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:39:36 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:39:36 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:39:36 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:39:36 INFO - Running setup.py install for mozleak 08:39:37 INFO - Running setup.py install for mozlog 08:39:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:39:37 INFO - Running setup.py install for moznetwork 08:39:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:39:37 INFO - Running setup.py install for mozprocess 08:39:37 INFO - Running setup.py install for mozprofile 08:39:37 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:39:37 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:39:37 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:39:37 INFO - Running setup.py install for mozrunner 08:39:37 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:39:37 INFO - Running setup.py install for mozscreenshot 08:39:37 INFO - Running setup.py install for moztest 08:39:37 INFO - Running setup.py install for mozversion 08:39:37 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:39:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:37 INFO - Cleaning up... 08:39:37 INFO - Return code: 0 08:39:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:37 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 0x7f2a8a369f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290e360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299d540>, '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 0x299e440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299e8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', '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:39:37 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:39:37 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:39:37 INFO - Using env: {'DISPLAY': ':0', 08:39:37 INFO - 'HOME': '/home/cltbld', 08:39:37 INFO - 'LANG': 'en_US.UTF-8', 08:39:37 INFO - 'LANGUAGE': 'en_US:en', 08:39:37 INFO - 'LOGNAME': 'cltbld', 08:39:37 INFO - 'MAIL': '/var/mail/cltbld', 08:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:37 INFO - 'MOZ_NO_REMOTE': '1', 08:39:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:37 INFO - 'NO_EM_RESTART': '1', 08:39:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:37 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:37 INFO - 'SHELL': '/bin/bash', 08:39:37 INFO - 'SHLVL': '1', 08:39:37 INFO - 'TERM': 'linux', 08:39:37 INFO - 'TMOUT': '86400', 08:39:37 INFO - 'USER': 'cltbld', 08:39:37 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', 08:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:37 INFO - '_': '/tools/buildbot/bin/python'} 08:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:39:38 INFO - Running setup.py (path:/tmp/pip-qllYf5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:39:38 INFO - Running setup.py (path:/tmp/pip-o1T2A5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:39:38 INFO - Running setup.py (path:/tmp/pip-U6kKWG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:39:38 INFO - Running setup.py (path:/tmp/pip-QnMp9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:39:38 INFO - Running setup.py (path:/tmp/pip-l6G_eQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:39:38 INFO - Running setup.py (path:/tmp/pip-Ul7h2c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:39:38 INFO - Running setup.py (path:/tmp/pip-B0seQr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:39:38 INFO - Running setup.py (path:/tmp/pip-r_5wEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:39:38 INFO - Running setup.py (path:/tmp/pip-tnqZ6Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:39:38 INFO - Running setup.py (path:/tmp/pip-j3sahO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:39:38 INFO - Running setup.py (path:/tmp/pip-5E5C7M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:39:38 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:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:39:38 INFO - Running setup.py (path:/tmp/pip-8nmoMW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:39:39 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:39:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:39:39 INFO - Running setup.py (path:/tmp/pip-jytWHc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:39:39 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:39:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:39:39 INFO - Running setup.py (path:/tmp/pip-RZu8Dx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:39:39 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:39:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:39:39 INFO - Running setup.py (path:/tmp/pip-PrQoRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:39:39 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:39:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:39:39 INFO - Running setup.py (path:/tmp/pip-26zG0C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:39:39 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:39:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:39:39 INFO - Running setup.py (path:/tmp/pip-OeI9Pl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:41 INFO - Downloading blessings-1.6.tar.gz 08:39:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:41 INFO - Installing collected packages: blessings 08:39:41 INFO - Running setup.py install for blessings 08:39:41 INFO - Successfully installed blessings 08:39:41 INFO - Cleaning up... 08:39:41 INFO - Return code: 0 08:39:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:39:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:39:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:39:41 INFO - Reading from file tmpfile_stdout 08:39:41 INFO - Current package versions: 08:39:41 INFO - argparse == 1.2.1 08:39:41 INFO - blessings == 1.6 08:39:41 INFO - blobuploader == 1.2.4 08:39:41 INFO - docopt == 0.6.1 08:39:41 INFO - manifestparser == 1.1 08:39:41 INFO - mozInstall == 1.12 08:39:41 INFO - mozcrash == 0.16 08:39:41 INFO - mozdebug == 0.1 08:39:41 INFO - mozdevice == 0.48 08:39:41 INFO - mozfile == 1.2 08:39:41 INFO - mozhttpd == 0.7 08:39:41 INFO - mozinfo == 0.9 08:39:41 INFO - mozleak == 0.1 08:39:41 INFO - mozlog == 3.1 08:39:41 INFO - moznetwork == 0.27 08:39:41 INFO - mozprocess == 0.22 08:39:41 INFO - mozprofile == 0.28 08:39:41 INFO - mozrunner == 6.11 08:39:41 INFO - mozscreenshot == 0.1 08:39:41 INFO - mozsystemmonitor == 0.0 08:39:41 INFO - moztest == 0.7 08:39:41 INFO - mozversion == 1.4 08:39:41 INFO - psutil == 3.1.1 08:39:41 INFO - requests == 1.2.3 08:39:41 INFO - wsgiref == 0.1.2 08:39:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:41 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 0x7f2a8a369f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290e360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299d540>, '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 0x299e440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299e8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', '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:39:41 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:39:41 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:39:41 INFO - Using env: {'DISPLAY': ':0', 08:39:41 INFO - 'HOME': '/home/cltbld', 08:39:41 INFO - 'LANG': 'en_US.UTF-8', 08:39:41 INFO - 'LANGUAGE': 'en_US:en', 08:39:41 INFO - 'LOGNAME': 'cltbld', 08:39:41 INFO - 'MAIL': '/var/mail/cltbld', 08:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:41 INFO - 'MOZ_NO_REMOTE': '1', 08:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:41 INFO - 'NO_EM_RESTART': '1', 08:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:41 INFO - 'SHELL': '/bin/bash', 08:39:41 INFO - 'SHLVL': '1', 08:39:41 INFO - 'TERM': 'linux', 08:39:41 INFO - 'TMOUT': '86400', 08:39:41 INFO - 'USER': 'cltbld', 08:39:41 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', 08:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:41 INFO - '_': '/tools/buildbot/bin/python'} 08:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 INFO - Cleaning up... 08:39:41 INFO - Return code: 0 08:39:41 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:41 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 0x7f2a8a369f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290e360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299d540>, '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 0x299e440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299e8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', '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:39:41 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:39:41 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:39:41 INFO - Using env: {'DISPLAY': ':0', 08:39:41 INFO - 'HOME': '/home/cltbld', 08:39:41 INFO - 'LANG': 'en_US.UTF-8', 08:39:41 INFO - 'LANGUAGE': 'en_US:en', 08:39:41 INFO - 'LOGNAME': 'cltbld', 08:39:41 INFO - 'MAIL': '/var/mail/cltbld', 08:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:41 INFO - 'MOZ_NO_REMOTE': '1', 08:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:41 INFO - 'NO_EM_RESTART': '1', 08:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:41 INFO - 'SHELL': '/bin/bash', 08:39:41 INFO - 'SHLVL': '1', 08:39:41 INFO - 'TERM': 'linux', 08:39:41 INFO - 'TMOUT': '86400', 08:39:41 INFO - 'USER': 'cltbld', 08:39:41 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', 08:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:41 INFO - '_': '/tools/buildbot/bin/python'} 08:39:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:42 INFO - Downloading/unpacking jsonschema 08:39:42 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:39:42 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:39:42 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:39:42 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:39:42 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:39:42 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:39:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:43 INFO - Downloading/unpacking functools32 (from jsonschema) 08:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:44 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:44 INFO - warning: no files found matching '*.txt' 08:39:44 INFO - no previously-included directories found matching 'build' 08:39:44 INFO - no previously-included directories found matching 'dist' 08:39:44 INFO - no previously-included directories found matching '.git*' 08:39:44 INFO - Installing collected packages: jsonschema, functools32 08:39:44 INFO - Running setup.py install for functools32 08:39:44 INFO - warning: no files found matching '*.txt' 08:39:44 INFO - no previously-included directories found matching 'build' 08:39:44 INFO - no previously-included directories found matching 'dist' 08:39:44 INFO - no previously-included directories found matching '.git*' 08:39:44 INFO - Successfully installed jsonschema functools32 08:39:44 INFO - Cleaning up... 08:39:44 INFO - Return code: 0 08:39:44 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:39: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:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:44 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 0x7f2a8a369f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290e360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299d540>, '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 0x299e440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299e8f0>, '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': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', '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:39:44 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:39:44 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:39:44 INFO - Using env: {'DISPLAY': ':0', 08:39:44 INFO - 'HOME': '/home/cltbld', 08:39:44 INFO - 'LANG': 'en_US.UTF-8', 08:39:44 INFO - 'LANGUAGE': 'en_US:en', 08:39:44 INFO - 'LOGNAME': 'cltbld', 08:39:44 INFO - 'MAIL': '/var/mail/cltbld', 08:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:44 INFO - 'MOZ_NO_REMOTE': '1', 08:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:44 INFO - 'NO_EM_RESTART': '1', 08:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:44 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:44 INFO - 'SHELL': '/bin/bash', 08:39:44 INFO - 'SHLVL': '1', 08:39:44 INFO - 'TERM': 'linux', 08:39:44 INFO - 'TMOUT': '86400', 08:39:44 INFO - 'USER': 'cltbld', 08:39:44 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', 08:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:44 INFO - '_': '/tools/buildbot/bin/python'} 08:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:44 INFO - Downloading/unpacking flake8 08:39:44 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:39:44 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:39:44 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:39:44 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:39:44 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:39:44 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:39:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:39:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:39:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:39:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:39:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:39:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:39:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:39:47 INFO - no previously-included directories found matching 'docs/_build' 08:39:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:39:47 INFO - Running setup.py install for pep8 08:39:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:39:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:39:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:39:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:39:47 INFO - no previously-included directories found matching 'docs/_build' 08:39:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:39:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:39:47 INFO - Cleaning up... 08:39:47 INFO - Return code: 0 08:39:47 INFO - Running post-action listener: _resource_record_post_action 08:39:47 INFO - Running post-action listener: _start_resource_monitoring 08:39:47 INFO - Starting resource monitoring. 08:39:47 INFO - ##### 08:39:47 INFO - ##### Running install step. 08:39:47 INFO - ##### 08:39:47 INFO - Running pre-action listener: _resource_record_pre_action 08:39:47 INFO - Running main action method: install 08:39:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:39:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:39:47 INFO - Reading from file tmpfile_stdout 08:39:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:39:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:39:47 INFO - Reading from file tmpfile_stdout 08:39:47 INFO - Output received: 08:39:47 INFO - Usage: mozinstall [options] installer 08:39:47 INFO - Options: 08:39:47 INFO - -h, --help show this help message and exit 08:39:47 INFO - -d DEST, --destination=DEST 08:39:47 INFO - Directory to install application into. [default: 08:39:47 INFO - "/builds/slave/test-pgo"] 08:39:47 INFO - --app=APP Application being installed. [default: firefox] 08:39:47 INFO - mkdir: /builds/slave/test-pgo/build/application 08:39:47 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:39:47 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:40:03 INFO - Reading from file tmpfile_stdout 08:40:03 INFO - Output received: 08:40:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:40:03 INFO - Running post-action listener: _resource_record_post_action 08:40:03 INFO - ##### 08:40:03 INFO - ##### Running run-tests step. 08:40:03 INFO - ##### 08:40:03 INFO - Running pre-action listener: _resource_record_pre_action 08:40:03 INFO - Running main action method: run_tests 08:40:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:40:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:40:03 INFO - Python 2.7.3 08:40:03 INFO - Return code: 0 08:40:03 INFO - grabbing minidump binary from tooltool 08:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:03 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 0x299d540>, '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 0x299e440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299e8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:40:03 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:40:03 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:40:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:40:03 INFO - Return code: 0 08:40:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:40:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:40:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:40:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:40:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:40:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:40:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:40:04 INFO - Return code: 0 08:40:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:40:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:40:04 INFO - Using env: {'DISPLAY': ':0', 08:40:04 INFO - 'HOME': '/home/cltbld', 08:40:04 INFO - 'LANG': 'en_US.UTF-8', 08:40:04 INFO - 'LANGUAGE': 'en_US:en', 08:40:04 INFO - 'LOGNAME': 'cltbld', 08:40:04 INFO - 'MAIL': '/var/mail/cltbld', 08:40:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:40:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:04 INFO - 'MOZ_NO_REMOTE': '1', 08:40:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:04 INFO - 'NO_EM_RESTART': '1', 08:40:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:40:04 INFO - 'SHELL': '/bin/bash', 08:40:04 INFO - 'SHLVL': '1', 08:40:04 INFO - 'TERM': 'linux', 08:40:04 INFO - 'TMOUT': '86400', 08:40:04 INFO - 'USER': 'cltbld', 08:40:04 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456', 08:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:04 INFO - '_': '/tools/buildbot/bin/python'} 08:40:04 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:40:05 INFO - mozversion application_buildid: 20160125030203 08:40:05 INFO - mozversion application_changeset: 67c66c2878aed17ae3096d7db483ddbb2293c503 08:40:05 INFO - mozversion application_display_name: Nightly 08:40:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:40:05 INFO - mozversion application_name: Firefox 08:40:05 INFO - mozversion application_remotingname: firefox 08:40:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:40:05 INFO - mozversion application_vendor: Mozilla 08:40:05 INFO - mozversion application_version: 46.0a1 08:40:05 INFO - mozversion platform_buildid: 20160125030203 08:40:05 INFO - mozversion platform_changeset: 67c66c2878aed17ae3096d7db483ddbb2293c503 08:40:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:40:05 INFO - mozversion platform_version: 46.0a1 08:40:05 INFO - using testdate: 1453740005 08:40:05 INFO - actual date: 1453740005 08:40:06 INFO - starting webserver on 'localhost:36485' 08:40:06 INFO - SUITE-START | Running 3 tests 08:40:06 INFO - TEST-START | dromaeo_css 08:40:06 INFO - operating with platform_type : linux_ 08:40:06 INFO - Initialising browser for dromaeo_css test... 08:40:06 INFO - TEST-INFO | started process 7597 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiww7YB/profile http://localhost:36485/getInfo.html) 08:40:10 INFO - PROCESS | 7597 | __metrics Screen width/height:1600/1200 08:40:10 INFO - PROCESS | 7597 | colorDepth:24 08:40:10 INFO - PROCESS | 7597 | Browser inner width/height: 1024/697 08:40:10 INFO - PROCESS | 7597 | __metrics 08:40:10 INFO - PROCESS | 7597 | 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:40:10 INFO - PROCESS | 7597 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:40:11 INFO - TEST-INFO | 7597: exit 0 08:40:11 INFO - Browser initialized. 08:40:11 INFO - Running cycle 1/1 for dromaeo_css test... 08:40:11 INFO - TEST-INFO | started process 7687 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiww7YB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:23 INFO - PROCESS | 7687 | RSS: Main: 147963904 08:40:23 INFO - PROCESS | 7687 | 08:41:14 INFO - PROCESS | 7687 | 1453740074408 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:43:22 INFO - PROCESS | 7687 | Cycle 1(1): loaded http://localhost:36485/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36485/tests/dromaeo/cssquery-ext.html) 08:43:23 INFO - PROCESS | 7687 | RSS: Main: 269029376 08:43:23 INFO - PROCESS | 7687 | 08:46:26 INFO - PROCESS | 7687 | Cycle 1(1): loaded http://localhost:36485/tests/dromaeo/cssquery-ext.html (next: http://localhost:36485/tests/dromaeo/cssquery-jquery.html) 08:46:27 INFO - PROCESS | 7687 | RSS: Main: 230789120 08:46:27 INFO - PROCESS | 7687 | 08:49:29 INFO - PROCESS | 7687 | Cycle 1(1): loaded http://localhost:36485/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36485/tests/dromaeo/cssquery-mootools.html) 08:49:29 INFO - PROCESS | 7687 | RSS: Main: 230154240 08:49:29 INFO - PROCESS | 7687 | 08:52:31 INFO - PROCESS | 7687 | Cycle 1(1): loaded http://localhost:36485/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36485/tests/dromaeo/cssquery-prototype.html) 08:52:32 INFO - PROCESS | 7687 | RSS: Main: 215285760 08:52:32 INFO - PROCESS | 7687 | 08:55:34 INFO - PROCESS | 7687 | Cycle 1(1): loaded http://localhost:36485/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36485/tests/dromaeo/cssquery-yui.html) 08:55:35 INFO - PROCESS | 7687 | RSS: Main: 219545600 08:55:35 INFO - PROCESS | 7687 | 08:58:37 INFO - PROCESS | 7687 | Cycle 1(1): loaded http://localhost:36485/tests/dromaeo/cssquery-yui.html (next: http://localhost:36485/tests/dromaeo/cssquery-dojo.html) 08:58:38 INFO - PROCESS | 7687 | RSS: Main: 376188928 08:58:38 INFO - PROCESS | 7687 | 08:58:38 INFO - PROCESS | 7687 | __start_tp_report 08:58:38 INFO - PROCESS | 7687 | _x_x_mozilla_page_load 08:58:38 INFO - PROCESS | 7687 | _x_x_mozilla_page_load_details 08:58:38 INFO - PROCESS | 7687 | |i|pagename|runs| 08:58:38 INFO - PROCESS | 7687 | |0;dojo.html;3145.9685403145963;3153.7792354535186;3164.794288371256;3169.4295026895165;3204.919877003075;5060.139776238039;5060.772265248063;5077.593792496601;5096.490350964907;5097.413797413298;5111.795528178868;5119.411267704215;5166.638335316529;5175.482451754822;5178.792848286073;4536.841210557631;4659.464161621406;4707.388039554853;4789.880252993686;4830.758462076882;4662.230731929245;4749.976250118744;4776.47458779534;4791.904161916759;4904.215325547913;4666.463356713971;4733.053389322149;4752.453467851206;4753.714777113384;4755.643326750507;4665.836695715634;4691.530846915315;4702.905941881178;4731.172044892164;4756.952430475721;4608.354830323758;4674.065186962621;4678.298255261704;4691.507391723854;4703.270992996091;5000.2499625056535;5064.2403639454005;5077.26379674945;5097.2608971699265;5097.7960881564695;5564.4713752193475;5570.442955704438;5579.414161513064;5584.888302233973;5585.497305242548;5470.7264636768;5610.887782244373;5616.129499927477;5620.718964051781;5624.437556244384;5153.845384638429;5247.212918062283;5309.41596424393;5337;5337.572994160497;5707.058335374617;5715.742791574389;5716.056850619684;5740.225069615632;5749.626274292241;5496.1755736639825;5509.338879334426;5519.724013799294;5534.4742249486235;5545.584081193846;5459.235707001023;5509.807156749494;5544.0575102232715;5551.555875529948;5576.888462230814;5504.889902201933;5532.640378375393;5536.390996990328;5554.972330118941;5570.888582228333;5511.889762204733;5513.2005859150195;5523.7790488380815;5538.058530049821;5540.9168862467095;4151.356539736345;4227;4246.893827654333;4275.1022285319805;4309.525952145262;3843.9615603843604;3861.8455261789213;3874.903127421837;3894.6884249259992;3900.6099390061336;5143.7685304161405;5144.511271429283;5150.845474635767;5156.4070131935305;5156.845294641167;5410.998965191452;5501.449855014546;5507.531859791882;5556.138798486241;5644.604877658525;5162.845114646567;5165.199394093846;5167.844964651066;5176;5189.506996835295;4736.100140973204;4736.95263047372;4738.265568836836;4773.0453909218295;4782.067496838084;5684.005299072645;5754.395788442237;5774.133879918046;5847.736851841677;5876.676782776988;5493.505584497414;5493.862653433536;5525.972370138124;5526.032944234663;5534.695591742493;5645.266115405136;5729.914051289317;5731.971340143273;5732.57005724564;5733.2260144881575;5433.510984011458;5437.32033495813;5439.102548079522;5454.318210223722;5509.586780991362;5463.371712252982;5467.45325467466;5475.2334673145;5497.752601133038;5519.917201241904;5328.547073498796;5348.025931637546;5393.811216607557;5418.376886658085;5448;5449.700266485382;5485.753141108739;5486.725663716878;5487.451254874481;5517.972410137923;5334.386545547157;5346.652467589594;5349.705766182898;5354.223637572608;5399.865003374947;5307.389650190277;5329.600279978939;5404.081306177881;5417.620766546304;5437.8368648940595;5339.759710812945;5393.298871146726;5396.352437707344;5397.568194544506;5412 08:58:38 INFO - PROCESS | 7687 | |1;ext.html;516.6254465512502;526.1896679114162;529.5578192209505;541.1287826599178;542.3248056170069;27309.86345068277;27763.305917352052;35169.47245791315;35771.10572235695;35837.46243806338;38058.8097059515;38313.616863831354;38410;38497.807510962404;38571.80714096432;8455.069942306342;8635.39552231344;8639.00651425088;8649.09184535624;8650.13498650133;8379.95810020952;8472.534010629444;8505.31957443403;8507.61715722794;8536.061033286334;8515.276201522847;8600.268977136919;8776.166264204921;8824.985126710446;8827.691030813923;8678.522681252529;8755.956220218923;8760.299176065899;8772.254358379545;8773.605187766565;8610.311175105977;8700.564971751388;8738.956305218433;8743.781405464852;8746.212840844291;38838.22323553541;39298.41052384216;39334.409983850266;39358.40962385567;39370.8188754335;3116.1897906544464;3169.4611915974338;3259.3318369734384;3654.506641603376;3850.4224366344993;27656.86171569129;27717.168484945283;28181.718182818113;28227.15318540447;28920.27699307513;3710.239400922804;3726.4782930389765;3780.0360907968566;3808.638179372983;3958.8218530166214;210119;216138;216449.9177504118;216609;216733;55171;56242.43757562372;61073;62428.375716243165;64516.67741661262;61277.38722612806;61672.38327616756;61709.69145154246;61931.690341548005;62006;11552.6534203974;11646.94176529112;11649.941750291195;11667.824982625267;11677.59128430518;8594.226519613265;8836.513991730388;9217.400868943498;9479.668211612561;9507.904920950841;20318.492037699176;20549.691754623393;20561.97190140517;20582.912563115653;20608;8212.876806847902;8323.923535818885;8324.29243514296;8519.829603407898;8588.699395521251;985.4284514981293;1007.8913195484907;1031.8194315994672;1080.8540846985713;1124.398446830958;28809.27976800555;28864.121366361647;28898.42203155925;28969;29268.414631707674;1010.6412223660642;1051.1275641217771;1054.2040759226734;1089.0525243038448;1134.1040577943497;15067.698646027018;16212.837871621134;16476.42332518356;16508.587285317724;16728.58178545522;462167;464871;465696;465828;466030;49264.50735492599;49749.50250497449;49770.75114624404;49802.75098624556;49825.50174498281;1334.759743246225;1339.77223871942;1342.7180292138564;1349.3455673998103;1452.7457694903349;26788;28334.71665283321;28659.713402865706;30172.54741178928;31732.20669483189;43149.78425107854;44183.77908110568;48147.27779083387;49419;49880.25179622381;332138;332855;337371;337773;337777;35864.641353587176;38213;41769.734539818055;42181.78909105557;42421.15157696891;36871.63128368789;42045;42486.5751342495;42520.57479425166;43495;35677.46483802693;35730.10674733153;36044.27911441809;40508.79745601253;41592.58407415887;35200.47199292064;36034.352510834266;36898.26203475969;36959.63040369562;37127.44308835315;36126;36421.63578364289;36534.8173259132;37889;38674.226515470094;31344.843275783474;32791.50812737763;33186.17034574155;39574;40932.59067409407;28795.42409151847;29026.854865726382;29107.708922911348;29578;29676.851615742646 08:58:38 INFO - PROCESS | 7687 | |2;jquery.html;365.98536058557653;367.25630598038987;369.97595156314844;372.6590169994455;373.48832100022975;13261.801072983913;13412.26232557209;15531.301091450883;17209.483715488524;18155.09224538771;14796.556103316918;14884.925575372135;15045.473408430707;15046.24768761563;15604.375824967015;5259.973700131503;5477.20580515825;5479.945200547983;5480.205370221315;5483.314585676791;3954.4463775071513;4093.6111069448357;5369.919451208235;5423.674579525222;5635.070213414781;5716.394979947719;5821.417858214187;5823.505002074829;5827.737751801179;5829.213056237418;5837.387074357195;5943.375945525744;5963.403659634046;5973.731182096816;5977.4022597740095;4873.683210591335;5073.2643766654;5076.695398276115;5268.341457317835;5276.657017293864;12317.938410307981;12487.937560312232;15037.548873533811;18693.813061869478;18701.906490467598;2094.1414020251623;2107.2835236019673;2112.8732276063483;2152.4834039830484;2241.820654347648;9029.729108126767;9301.674441394518;9363.157315841607;9370.765730856714;9403.200727938134;1756.262369804685;1803.7835459744783;1811.1759149586906;1844.7601811764384;1855.5082903030707;49271;49408.258876117245;49848;53548.196777048375;55678;9831.213502919749;10033.19734421259;10130;10173.389596624227;10208.744781380525;13139.934300328438;13250.801237981437;13251.337433128305;13258.204507729568;13260;6643.933560664428;6658.6337751424135;6695.564788288746;6725.66371681414;6772.72909083641;6180.721867515973;6185.876282474325;6206;6215.9378406216265;6220.160278362454;4438.4451943507065;4461.063176732858;4469.888252793706;4489;4509.864704058883;1715.313874450205;1754.2632094520332;1769.716845304745;1846.7783865936174;1862.7891870284152;901.197933838884;976.6825781621002;993.5876611206413;1030.896910308963;1065.3661071662348;15770.526884193492;16207.594810129842;16591.336346546243;16844.157792110345;17048.744268835977;888.5868071346725;927.2859897878595;927.3045216087934;928.6146249306462;996.1632228927735;8781.517016564023;8995.730128096167;9023.323250756088;9080.137386948229;9112;547501;554962;556061;586386;588759;59953.40046599478;60598;63253.68373158105;70150.64924675344;70946;947.3984020147257;1020.2042406922612;1047.77870913662;1092.8306112552566;1138.8234823602354;13930.373133209232;15001.474948376754;15079.924600376928;15153.393864245307;15384.923075384551;31677.366452670358;32376;32792;32831;33132;41850.581494185884;42000.789996049825;42252.57747422486;42353.57646423496;42863.57136428721;6966.756163534455;7125.8574828502105;7175.461840362098;7266.2007179211305;7363.116426028697;3450.1202193440513;5571.66570005801;7732.806679833049;8621.180987806149;10297.3821570706;8691.348148888732;8886.555672216235;8938.68714594986;9128.634854606007;9178.036306187754;8858.73423797287;8910.86633700508;9027.18090629519;9239.815203695754;9259.86110208334;9448.811023779348;9483.66807161746;9676.177524910461;9856.112949834549;9935.751606209613;7055.506114572136;7162.173645720308;7296.96351518239;7434.936810030601;7459.291367320096;9079.409838360485;9384.57769400365;9933.801323973625;10054.89945100569;10069.345492542961 08:58:38 INFO - PROCESS | 7687 | |3;mootools.html;1292.6186774901403;1454.8108745863037;1472.6980968901373;1635.2804765903002;1793.0496836676566;6742.325767423261;7322.340989310961;7427.034485516882;7456.0307160069115;7465;7411.0736157980255;7417.740379086733;7441.255874412556;7490.288422599858;7509.511881727698;1935.2549268531645;1985.2852972929734;2279.4415368234804;2301.8618882867;2303.3205204464725;2219.145628932856;2292.610256256432;2292.7275362173987;2293.0598454633605;2293.919712810052;2171.9457013574706;2188.3763127508664;2205.6250437425674;2209.248855389167;2223.4663680716594;2163.664631982045;2168.6530155175174;2174.195547647365;2194.692743015979;2230.7992280694652;2169.39257008038;2215.4129155773735;2220.034285085993;2226.476777957179;2244.2930476899887;7551.509151905108;7623.504472209289;7626.733064342777;7630.8855367169535;7631.465797394185;4411.823527058914;4552.271636538171;4556.612687921497;4558.544145585448;4571.154336447735;2888.3501212227293;2895.5367141257298;2931.92670183245;2939.8824047038306;3055.9694403055905;995.2386424385351;1002.7192386131894;1031.8091153136693;1040.266612038511;1048.1405247696891;10557.736056598647;10585.470726463645;10586.788264234749;10588.947055264674;10601.575936962512;4050.9594904051173;4120.237756015147;4129.256733787887;4199.37009448579;4264.722793018444;9057.18485336323;9096.363254572116;9100.681476148304;9114.954425227965;9121.22469590079;4522.29904364824;4532.9320060199125;4557.886052848706;4558.88602784933;4583.381243532147;4135.0902801383645;4138.813753381105;4146.709730318909;4148.62662360383;4163.604457576525;3377.155711072232;3432.2105915639045;3594.0655429587973;3643.981780091083;3734.3091528067393;1193.8209268609778;1194.42070595761;1199.4782269712703;1211.497228650118;1216;1024.0271741845277;1047.1361127070197;1047.5547892145808;1186.9525218991316;1347.5620423362445;7009.509334346547;7112.182099058571;7126.643667816588;7149.0706208192605;7149.642517874189;1106.8948449897248;1110.134095405585;1126.245415571569;1129.3449799116493;1138.4478527913955;5543.390227075019;5618.747156377973;5619.662820230717;5620.325560932714;5621.325440947113;9083.772905677279;9139.131782480654;9341.159295663423;9351.953240233755;9462.668806591737;9220.631174752934;9248.075192480832;9336.719898403058;9360.765980850398;9363.204127649089;6823.590584564942;6930.5099403628465;6957.373836354753;7136.678849451787;7187.856242875113;7040.0847889774;7121.501494895308;7122.287771222836;7130.928690713234;7134.928650713634;7864.960675196817;8002;8054.556999364857;8055.919440805751;8062.596870156586;8040.5979701015885;8243.629036693483;8346.457480263764;8365.707200247962;8370.581470926307;6872.072270243653;6898.758543450955;6907.481938854707;6925.826854328682;6931.5097254090615;6339.5562310637815;6452.645104519296;6457.773977910751;6897.827554311182;7261.273872612696;6637.568558043712;6663.666816659051;6726.529142959946;6782.423494002867;6799.320067993359;6538.771143010162;6548.1814773153355;6565.540412171103;6587.571807832475;6734.225564060196;6414.358564143548;6444.9355506444335;6456.257530384066;6459.160309159779;6460.806175814733;6255.78104766331;6355.713992870425;6419.4864410846085;6427.775027874189;6428.839279017875;6220;6247.0629405589525;6268.404501572343;6275.34108918557;6279.2464904209955 08:58:38 INFO - PROCESS | 7687 | |4;prototype.html;322.34724682517896;325.6076427904375;327.355110432448;333.8864785972769;335.5252317970071;5833.679147646878;5858.20914176586;5903.704814759256;5916.7041647917595;5941.197938278331;5553.666779993203;5663.660180389169;5669.404712505179;5846.795362162326;5862.589618726691;4489.079738653568;4504.662150338721;4512.684112112153;4522.660800439964;4531.524189960056;4316.9136617267795;4519.796609152596;4528.117017181651;4530.886727831814;4535.750533720644;4355.847545335914;4382.452193475816;4465.88352911772;4483.820647174109;4496.505384407713;4429.889252768674;4457.799399027035;4478.529754375809;4479.753613551254;4481.058977614704;3924.038610540436;3929.7249192556533;3931.4889064421727;3935.74417662851;3941.113249518864;5467.480589344046;5550.000999820031;5559.16612508127;5570.3315602127595;5581.302337207849;5182.611304152204;5184.922226166611;5185.196294574347;5191.870203244911;5193.948060519384;6149.13912052313;6155.969220153871;6158.261008678943;6161.7535298588;6174.104754810573;4335.046289816235;4341.652667786601;4345.956540434587;4346;4347.869563913087;6300.87398252037;6430.7106180222;6443.516736244754;6444.484441244689;6444.774432894873;4433.8669839904205;4440.933385999213;4441.600255976978;4446;4448.644108471314;4494.52807455219;4499.482559505699;4503;4503.279475283939;4505.81976720934;5155.175171972542;5158.896822063538;5175.870603234949;5177.275181474596;5179.378474583074;6106.084087386927;6201;6220.129181914535;6229.688515574203;6233.875322493524;1578.9605259868595;1602.543275166572;1602.543275166572;1606.8232494425604;1609.629785149422;1038.2628333882876;1040.6097713357492;1062.4209805655937;1078.8867168947304;1084.7559299157626;5909.23179986599;5917.053271476543;5930.495907847795;5931.9406805931385;5938.435848594377;6388.39310265524;6389.456896163878;6392.936070639327;6401.935980640227;6421.325760795049;5694.373618901917;5793.826185214451;5803.071508558611;5892.587518873637;5911.881762364728;3441.5698037745283;3470.965290347064;3473.1664400543686;3478.6347433519622;3481.6518348165487;6584.473242140617;6599.208095028532;6611.305812889577;6612.801615951529;6614.140161778938;6392.904106438407;6580.80257592273;6618.768343107968;6625.900611490832;6636.104125942936;6760.459163266927;6832.624205668736;6840.794776156723;6843.452523797984;6848.760293389807;6432.6140431572385;6472.996685513753;6481.740730370732;6484.675766211576;6493.902591461037;6278.309385967631;6391.552591318749;6393.104965304768;6410.326915673973;6411.262704788823;6740.090087838079;6744.932550674431;6745.055692202997;6745.460363170836;6751.122354093936;4387.583179597933;4400.955990440055;4423.270160423623;4424.225760491837;4426;6360.06713569239;6389.9041514376395;6457.128287681103;6460.709268083042;6469.77355792545;6284.245890492987;6287.2140982377205;6294.874102518015;6304.085907543289;6305.770374776875;6240.219972503437;6277;6288.27684816252;6293.685315734104;6304.65324407162;6056.939430605637;6160.630362178284;6162.661053642093;6167.044108163242;6195.2255968004;6301.590396624205;6306.054091886253;6319.494440444845;6330.683465826598;6333.050042493663;6184.196054512884;6184.628922264678;6186.752529898754;6188.566800324114;6193.473554747897 08:58:38 INFO - PROCESS | 7687 | |5;yui.html;714.8606021825743;792.615581443;811.1807074854395;815.522919092331;834.4867906237665;12675.49298028079;12884.355782210887;12924.353782310895;12936.094473386867;12979.156354836929;11219.887801121986;11230.66308010759;11240.606578769744;11261.831072533918;11269.492872820743;646.5861848417017;657.9013148027786;792.2948575767572;796.0646240667207;807.4590024683476;788.9013873265842;790.7074382478492;798.2416704131069;798.4769975665919;801.935845132388;691.7163962775263;845.1464021338462;851.940364174508;853.6116067189445;854.2567965869702;695.2942763095463;821.6918655504186;836.5775283481834;837.2297486312607;837.7528629054443;608.1698481572621;613.3927411862269;613.5214532664529;613.5858295650418;613.9416755408274;12123.6362909112;12161.087918406067;12179.939100304442;12198.39008049594;12248.632541023784;11124.888751112467;11700.941495292554;11733.4719937603;12006.399680015964;12306.630801075982;9623.759406014835;9691.176250018756;9732.710056334688;9950.850737238947;9970;3496.17839807645;3526.717862570988;3582.408902531079;3598.6941110005682;3676.6690997810324;46491;46748.130074796965;47032.76483617594;47206;47995.28007079862;9685.612575496902;9687.951560242294;9698;9764.072413120743;9810;15053.698926021418;15344.923275383775;15398.769018464733;15408;15412;7101.9289807102305;7103.218645948941;7106.502544821813;7139.750108746169;7310.597917114504;3954.54522729884;3965.206958608232;4058.9594104059174;4096.078382364004;4117.958820411817;2913.839738814386;2952.9704702953127;2956.9408611827644;2956.9556456653168;2959.5116805727243;516.2256615077384;533.6237952243658;541.4504278157673;543.570579242394;543.6167501911143;608.6135304081852;619.1641284266294;642.9774957876452;646.4505170604948;657.5298661456985;7819.804504887424;7830.765077047698;7905.418208291397;7932.603369831485;8056.154103819132;453.2770231480783;497.84815631232095;600.9308929473079;612.3386742318286;641.4419455074022;3631.6913062389995;3707.6107008763693;3738.5887552369218;3850.6534411903062;3885.747426417274;56268;58219.417805822246;58251.12623310654;58336.70831645815;58394;50144.247836282484;51845;51865;52261.2160817588;52522;45279;46602.766986164854;47075;47707.52292477031;47732.284015739795;7498.700051997859;7631.732889348847;7634;7641.808954776175;7755.379569634303;33901;34687.65312346945;34868.128296792784;35497.46753798747;37850.24299514049;42564.36153457639;42787.57212427836;43759.343609845244;43846.49228061683;44384.77807610941;10514.842277365693;10729.933206440544;10767.192460565333;10953.288036277616;11034.613788517363;11860.14817751581;11905.047596192111;12189.939050304693;12198.268103913793;12348.876511234772;10740.946295268473;11001.944990274997;11074.39090850011;11336.489857956576;11750.353730544903;10645.520951557044;10680.679579612624;11019.889801101886;11032.724181895517;11032.724181895517;8467.195616416431;9691.224702023963;10074.19406447497;10546.419946902686;10565.577376904837;8456.154384561494;8808.295336373203;9065.138811812867;9472.242220622471;9782.41305521671;8123.5532045738055;8948.73153805387;9373.625054997996;9557.90442095598;9568.425894446356 08:58:38 INFO - PROCESS | 7687 | __end_tp_report 08:58:38 INFO - PROCESS | 7687 | __start_cc_report 08:58:38 INFO - PROCESS | 7687 | _x_x_mozilla_cycle_collect,1024 08:58:38 INFO - PROCESS | 7687 | __end_cc_report 08:58:38 INFO - PROCESS | 7687 | __startTimestamp1453741118195__endTimestamp 08:58:38 INFO - PROCESS | 7687 | 08:58:38 INFO - PROCESS | 7687 | ------- Summary: start ------- 08:58:38 INFO - PROCESS | 7687 | Number of tests: 6 08:58:38 INFO - PROCESS | 7687 | 08:58:38 INFO - PROCESS | 7687 | [#0] dojo.html Cycles:165 Average:5151.90 Median:5349.71 stddev:562.03 (10.5%) stddev-sans-first:541.28 08:58:38 INFO - PROCESS | 7687 | Values: 3146.0 3153.8 3164.8 3169.4 3204.9 5060.1 5060.8 5077.6 5096.5 5097.4 5111.8 5119.4 5166.6 5175.5 5178.8 4536.8 4659.5 4707.4 4789.9 4830.8 4662.2 4750.0 4776.5 4791.9 4904.2 4666.5 4733.1 4752.5 4753.7 4755.6 4665.8 4691.5 4702.9 4731.2 4757.0 4608.4 4674.1 4678.3 4691.5 4703.3 5000.2 5064.2 5077.3 5097.3 5097.8 5564.5 5570.4 5579.4 5584.9 5585.5 5470.7 5610.9 5616.1 5620.7 5624.4 5153.8 5247.2 5309.4 5337.0 5337.6 5707.1 5715.7 5716.1 5740.2 5749.6 5496.2 5509.3 5519.7 5534.5 5545.6 5459.2 5509.8 5544.1 5551.6 5576.9 5504.9 5532.6 5536.4 5555.0 5570.9 5511.9 5513.2 5523.8 5538.1 5540.9 4151.4 4227.0 4246.9 4275.1 4309.5 3844.0 3861.8 3874.9 3894.7 3900.6 5143.8 5144.5 5150.8 5156.4 5156.8 5411.0 5501.4 5507.5 5556.1 5644.6 5162.8 5165.2 5167.8 5176.0 5189.5 4736.1 4737.0 4738.3 4773.0 4782.1 5684.0 5754.4 5774.1 5847.7 5876.7 5493.5 5493.9 5526.0 5526.0 5534.7 5645.3 5729.9 5732.0 5732.6 5733.2 5433.5 5437.3 5439.1 5454.3 5509.6 5463.4 5467.5 5475.2 5497.8 5519.9 5328.5 5348.0 5393.8 5418.4 5448.0 5449.7 5485.8 5486.7 5487.5 5518.0 5334.4 5346.7 5349.7 5354.2 5399.9 5307.4 5329.6 5404.1 5417.6 5437.8 5339.8 5393.3 5396.4 5397.6 5412.0 08:58:38 INFO - PROCESS | 7687 | 08:58:38 INFO - PROCESS | 7687 | [#1] ext.html Cycles:180 Average:50232.95 Median:38263.31 stddev:93639.68 (244.7%) stddev-sans-first:93827.96 08:58:38 INFO - PROCESS | 7687 | Values: 516.6 526.2 529.6 541.1 542.3 27309.9 27763.3 35169.5 35771.1 35837.5 38058.8 38313.6 38410.0 38497.8 38571.8 8455.1 8635.4 8639.0 8649.1 8650.1 8380.0 8472.5 8505.3 8507.6 8536.1 8515.3 8600.3 8776.2 8825.0 8827.7 8678.5 8756.0 8760.3 8772.3 8773.6 8610.3 8700.6 8739.0 8743.8 8746.2 38838.2 39298.4 39334.4 39358.4 39370.8 3116.2 3169.5 3259.3 3654.5 3850.4 27656.9 27717.2 28181.7 28227.2 28920.3 3710.2 3726.5 3780.0 3808.6 3958.8 210119.0 216138.0 216449.9 216609.0 216733.0 55171.0 56242.4 61073.0 62428.4 64516.7 61277.4 61672.4 61709.7 61931.7 62006.0 11552.7 11646.9 11649.9 11667.8 11677.6 8594.2 8836.5 9217.4 9479.7 9507.9 20318.5 20549.7 20562.0 20582.9 20608.0 8212.9 8323.9 8324.3 8519.8 8588.7 985.4 1007.9 1031.8 1080.9 1124.4 28809.3 28864.1 28898.4 28969.0 29268.4 1010.6 1051.1 1054.2 1089.1 1134.1 15067.7 16212.8 16476.4 16508.6 16728.6 462167.0 464871.0 465696.0 465828.0 466030.0 49264.5 49749.5 49770.8 49802.8 49825.5 1334.8 1339.8 1342.7 1349.3 1452.7 26788.0 28334.7 28659.7 30172.5 31732.2 43149.8 44183.8 48147.3 49419.0 49880.3 332138.0 332855.0 337371.0 337773.0 337777.0 35864.6 38213.0 41769.7 42181.8 42421.2 36871.6 42045.0 42486.6 42520.6 43495.0 35677.5 35730.1 36044.3 40508.8 41592.6 35200.5 36034.4 36898.3 36959.6 37127.4 36126.0 36421.6 36534.8 37889.0 38674.2 31344.8 32791.5 33186.2 39574.0 40932.6 28795.4 29026.9 29107.7 29578.0 29676.9 08:58:38 INFO - PROCESS | 7687 | 08:58:38 INFO - PROCESS | 7687 | [#2] jquery.html Cycles:180 Average:27494.15 Median:29459.06 stddev:92522.66 (314.1%) stddev-sans-first:92759.78 08:58:38 INFO - PROCESS | 7687 | Values: 366.0 367.3 370.0 372.7 373.5 13261.8 13412.3 15531.3 17209.5 18155.1 14796.6 14884.9 15045.5 15046.2 15604.4 5260.0 5477.2 5479.9 5480.2 5483.3 3954.4 4093.6 5369.9 5423.7 5635.1 5716.4 5821.4 5823.5 5827.7 5829.2 5837.4 5943.4 5963.4 5973.7 5977.4 4873.7 5073.3 5076.7 5268.3 5276.7 12317.9 12487.9 15037.5 18693.8 18701.9 2094.1 2107.3 2112.9 2152.5 2241.8 9029.7 9301.7 9363.2 9370.8 9403.2 1756.3 1803.8 1811.2 1844.8 1855.5 49271.0 49408.3 49848.0 53548.2 55678.0 9831.2 10033.2 10130.0 10173.4 10208.7 13139.9 13250.8 13251.3 13258.2 13260.0 6643.9 6658.6 6695.6 6725.7 6772.7 6180.7 6185.9 6206.0 6215.9 6220.2 4438.4 4461.1 4469.9 4489.0 4509.9 1715.3 1754.3 1769.7 1846.8 1862.8 901.2 976.7 993.6 1030.9 1065.4 15770.5 16207.6 16591.3 16844.2 17048.7 888.6 927.3 927.3 928.6 996.2 8781.5 8995.7 9023.3 9080.1 9112.0 547501.0 554962.0 556061.0 586386.0 588759.0 59953.4 60598.0 63253.7 70150.6 70946.0 947.4 1020.2 1047.8 1092.8 1138.8 13930.4 15001.5 15079.9 15153.4 15384.9 31677.4 32376.0 32792.0 32831.0 33132.0 41850.6 42000.8 42252.6 42353.6 42863.6 6966.8 7125.9 7175.5 7266.2 7363.1 3450.1 5571.7 7732.8 8621.2 10297.4 8691.3 8886.6 8938.7 9128.6 9178.0 8858.7 8910.9 9027.2 9239.8 9259.9 9448.8 9483.7 9676.2 9856.1 9935.8 7055.5 7162.2 7297.0 7434.9 7459.3 9079.4 9384.6 9933.8 10054.9 10069.3 08:58:38 INFO - PROCESS | 7687 | 08:58:38 INFO - PROCESS | 7687 | [#3] mootools.html Cycles:180 Average:5295.65 Median:6251.42 stddev:2747.03 (43.9%) stddev-sans-first:2738.26 08:58:38 INFO - PROCESS | 7687 | Values: 1292.6 1454.8 1472.7 1635.3 1793.0 6742.3 7322.3 7427.0 7456.0 7465.0 7411.1 7417.7 7441.3 7490.3 7509.5 1935.3 1985.3 2279.4 2301.9 2303.3 2219.1 2292.6 2292.7 2293.1 2293.9 2171.9 2188.4 2205.6 2209.2 2223.5 2163.7 2168.7 2174.2 2194.7 2230.8 2169.4 2215.4 2220.0 2226.5 2244.3 7551.5 7623.5 7626.7 7630.9 7631.5 4411.8 4552.3 4556.6 4558.5 4571.2 2888.4 2895.5 2931.9 2939.9 3056.0 995.2 1002.7 1031.8 1040.3 1048.1 10557.7 10585.5 10586.8 10588.9 10601.6 4051.0 4120.2 4129.3 4199.4 4264.7 9057.2 9096.4 9100.7 9115.0 9121.2 4522.3 4532.9 4557.9 4558.9 4583.4 4135.1 4138.8 4146.7 4148.6 4163.6 3377.2 3432.2 3594.1 3644.0 3734.3 1193.8 1194.4 1199.5 1211.5 1216.0 1024.0 1047.1 1047.6 1187.0 1347.6 7009.5 7112.2 7126.6 7149.1 7149.6 1106.9 1110.1 1126.2 1129.3 1138.4 5543.4 5618.7 5619.7 5620.3 5621.3 9083.8 9139.1 9341.2 9352.0 9462.7 9220.6 9248.1 9336.7 9360.8 9363.2 6823.6 6930.5 6957.4 7136.7 7187.9 7040.1 7121.5 7122.3 7130.9 7134.9 7865.0 8002.0 8054.6 8055.9 8062.6 8040.6 8243.6 8346.5 8365.7 8370.6 6872.1 6898.8 6907.5 6925.8 6931.5 6339.6 6452.6 6457.8 6897.8 7261.3 6637.6 6663.7 6726.5 6782.4 6799.3 6538.8 6548.2 6565.5 6587.6 6734.2 6414.4 6444.9 6456.3 6459.2 6460.8 6255.8 6355.7 6419.5 6427.8 6428.8 6220.0 6247.1 6268.4 6275.3 6279.2 08:58:38 INFO - PROCESS | 7687 | 08:58:38 INFO - PROCESS | 7687 | [#4] prototype.html Cycles:180 Average:5213.11 Median:5898.15 stddev:1572.13 (26.7%) stddev-sans-first:1533.09 08:58:38 INFO - PROCESS | 7687 | Values: 322.3 325.6 327.4 333.9 335.5 5833.7 5858.2 5903.7 5916.7 5941.2 5553.7 5663.7 5669.4 5846.8 5862.6 4489.1 4504.7 4512.7 4522.7 4531.5 4316.9 4519.8 4528.1 4530.9 4535.8 4355.8 4382.5 4465.9 4483.8 4496.5 4429.9 4457.8 4478.5 4479.8 4481.1 3924.0 3929.7 3931.5 3935.7 3941.1 5467.5 5550.0 5559.2 5570.3 5581.3 5182.6 5184.9 5185.2 5191.9 5193.9 6149.1 6156.0 6158.3 6161.8 6174.1 4335.0 4341.7 4346.0 4346.0 4347.9 6300.9 6430.7 6443.5 6444.5 6444.8 4433.9 4440.9 4441.6 4446.0 4448.6 4494.5 4499.5 4503.0 4503.3 4505.8 5155.2 5158.9 5175.9 5177.3 5179.4 6106.1 6201.0 6220.1 6229.7 6233.9 1579.0 1602.5 1602.5 1606.8 1609.6 1038.3 1040.6 1062.4 1078.9 1084.8 5909.2 5917.1 5930.5 5931.9 5938.4 6388.4 6389.5 6392.9 6401.9 6421.3 5694.4 5793.8 5803.1 5892.6 5911.9 3441.6 3471.0 3473.2 3478.6 3481.7 6584.5 6599.2 6611.3 6612.8 6614.1 6392.9 6580.8 6618.8 6625.9 6636.1 6760.5 6832.6 6840.8 6843.5 6848.8 6432.6 6473.0 6481.7 6484.7 6493.9 6278.3 6391.6 6393.1 6410.3 6411.3 6740.1 6744.9 6745.1 6745.5 6751.1 4387.6 4401.0 4423.3 4424.2 4426.0 6360.1 6389.9 6457.1 6460.7 6469.8 6284.2 6287.2 6294.9 6304.1 6305.8 6240.2 6277.0 6288.3 6293.7 6304.7 6056.9 6160.6 6162.7 6167.0 6195.2 6301.6 6306.1 6319.5 6330.7 6333.1 6184.2 6184.6 6186.8 6188.6 6193.5 08:58:38 INFO - PROCESS | 7687 | 08:58:38 INFO - PROCESS | 7687 | [#5] yui.html Cycles:180 Average:13381.50 Median:25330.24 stddev:15983.72 (63.1%) stddev-sans-first:16000.25 08:58:38 INFO - PROCESS | 7687 | Values: 714.9 792.6 811.2 815.5 834.5 12675.5 12884.4 12924.4 12936.1 12979.2 11219.9 11230.7 11240.6 11261.8 11269.5 646.6 657.9 792.3 796.1 807.5 788.9 790.7 798.2 798.5 801.9 691.7 845.1 851.9 853.6 854.3 695.3 821.7 836.6 837.2 837.8 608.2 613.4 613.5 613.6 613.9 12123.6 12161.1 12179.9 12198.4 12248.6 11124.9 11700.9 11733.5 12006.4 12306.6 9623.8 9691.2 9732.7 9950.9 9970.0 3496.2 3526.7 3582.4 3598.7 3676.7 46491.0 46748.1 47032.8 47206.0 47995.3 9685.6 9688.0 9698.0 9764.1 9810.0 15053.7 15344.9 15398.8 15408.0 15412.0 7101.9 7103.2 7106.5 7139.8 7310.6 3954.5 3965.2 4059.0 4096.1 4118.0 2913.8 2953.0 2956.9 2957.0 2959.5 516.2 533.6 541.5 543.6 543.6 608.6 619.2 643.0 646.5 657.5 7819.8 7830.8 7905.4 7932.6 8056.2 453.3 497.8 600.9 612.3 641.4 3631.7 3707.6 3738.6 3850.7 3885.7 56268.0 58219.4 58251.1 58336.7 58394.0 50144.2 51845.0 51865.0 52261.2 52522.0 45279.0 46602.8 47075.0 47707.5 47732.3 7498.7 7631.7 7634.0 7641.8 7755.4 33901.0 34687.7 34868.1 35497.5 37850.2 42564.4 42787.6 43759.3 43846.5 44384.8 10514.8 10729.9 10767.2 10953.3 11034.6 11860.1 11905.0 12189.9 12198.3 12348.9 10740.9 11001.9 11074.4 11336.5 11750.4 10645.5 10680.7 11019.9 11032.7 11032.7 8467.2 9691.2 10074.2 10546.4 10565.6 8456.2 8808.3 9065.1 9472.2 9782.4 8123.6 8948.7 9373.6 9557.9 9568.4 08:58:38 INFO - PROCESS | 7687 | -------- Summary: end -------- 08:58:38 INFO - PROCESS | 7687 | 08:58:38 INFO - TEST-INFO | 7687: exit 0 08:58:38 INFO - TEST-OK | dromaeo_css | took 1112585ms 08:58:38 INFO - TEST-START | kraken 08:58:38 INFO - operating with platform_type : linux_ 08:58:38 INFO - Initialising browser for kraken test... 08:58:38 INFO - TEST-INFO | started process 7883 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5DFyGs/profile http://localhost:36485/getInfo.html) 08:58:42 INFO - PROCESS | 7883 | __metrics Screen width/height:1600/1200 08:58:42 INFO - PROCESS | 7883 | colorDepth:24 08:58:42 INFO - PROCESS | 7883 | Browser inner width/height: 1024/697 08:58:42 INFO - PROCESS | 7883 | __metrics 08:58:42 INFO - PROCESS | 7883 | 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:58:43 INFO - PROCESS | 7883 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:58:43 INFO - PROCESS | 7883 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:58:43 INFO - TEST-INFO | 7883: exit 0 08:58:43 INFO - Browser initialized. 08:58:43 INFO - Running cycle 1/1 for kraken test... 08:58:43 INFO - TEST-INFO | started process 7965 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5DFyGs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:55 INFO - PROCESS | 7965 | RSS: Main: 145924096 08:58:55 INFO - PROCESS | 7965 | 08:58:58 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36485/tests/kraken/driver.html?testName=audio-beat-detection) 08:58:58 INFO - PROCESS | 7965 | RSS: Main: 185081856 08:58:58 INFO - PROCESS | 7965 | 08:59:01 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36485/tests/kraken/driver.html?testName=audio-dft) 08:59:01 INFO - PROCESS | 7965 | RSS: Main: 175853568 08:59:01 INFO - PROCESS | 7965 | 08:59:04 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36485/tests/kraken/driver.html?testName=audio-fft) 08:59:05 INFO - PROCESS | 7965 | RSS: Main: 165253120 08:59:05 INFO - PROCESS | 7965 | 08:59:07 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36485/tests/kraken/driver.html?testName=audio-oscillator) 08:59:07 INFO - PROCESS | 7965 | RSS: Main: 164298752 08:59:07 INFO - PROCESS | 7965 | 08:59:10 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36485/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:59:10 INFO - PROCESS | 7965 | RSS: Main: 164069376 08:59:10 INFO - PROCESS | 7965 | 08:59:13 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36485/tests/kraken/driver.html?testName=imaging-darkroom) 08:59:14 INFO - PROCESS | 7965 | RSS: Main: 165531648 08:59:14 INFO - PROCESS | 7965 | 08:59:17 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36485/tests/kraken/driver.html?testName=imaging-desaturate) 08:59:18 INFO - PROCESS | 7965 | RSS: Main: 166731776 08:59:18 INFO - PROCESS | 7965 | 08:59:20 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36485/tests/kraken/driver.html?testName=json-parse-financial) 08:59:21 INFO - PROCESS | 7965 | RSS: Main: 165380096 08:59:21 INFO - PROCESS | 7965 | 08:59:23 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36485/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:59:23 INFO - PROCESS | 7965 | RSS: Main: 177397760 08:59:23 INFO - PROCESS | 7965 | 08:59:25 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36485/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:59:26 INFO - PROCESS | 7965 | RSS: Main: 174874624 08:59:26 INFO - PROCESS | 7965 | 08:59:28 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36485/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:28 INFO - PROCESS | 7965 | RSS: Main: 186929152 08:59:28 INFO - PROCESS | 7965 | 08:59:31 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:31 INFO - PROCESS | 7965 | RSS: Main: 194678784 08:59:31 INFO - PROCESS | 7965 | 08:59:34 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:34 INFO - PROCESS | 7965 | RSS: Main: 193196032 08:59:34 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | Cycle 1(1): loaded http://localhost:36485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36485/tests/kraken/driver.html?testName=ai-astar) 08:59:36 INFO - PROCESS | 7965 | RSS: Main: 253972480 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | __start_tp_report 08:59:36 INFO - PROCESS | 7965 | _x_x_mozilla_page_load 08:59:36 INFO - PROCESS | 7965 | _x_x_mozilla_page_load_details 08:59:36 INFO - PROCESS | 7965 | |i|pagename|runs| 08:59:36 INFO - PROCESS | 7965 | |0;ai-astar;111;112;105;112;112;112;113;113;105;110 08:59:36 INFO - PROCESS | 7965 | |1;audio-beat-detection;146;124;159;165;128;153;156;126;174;124 08:59:36 INFO - PROCESS | 7965 | |2;audio-dft;160;160;159;161;161;163;160;159;162;162 08:59:36 INFO - PROCESS | 7965 | |3;audio-fft;73;74;74;159;75;76;74;75;152;76 08:59:36 INFO - PROCESS | 7965 | |4;audio-oscillator;96;95;144;96;98;97;143;97;96;139 08:59:36 INFO - PROCESS | 7965 | |5;imaging-gaussian-blur;109;109;109;109;108;108;109;109;109;109 08:59:36 INFO - PROCESS | 7965 | |6;imaging-darkroom;146;145;146;146;147;146;146;145;145;146 08:59:36 INFO - PROCESS | 7965 | |7;imaging-desaturate;95;96;96;96;95;96;96;96;95;96 08:59:36 INFO - PROCESS | 7965 | |8;json-parse-financial;57;56;55;55;55;56;57;56;56;53 08:59:36 INFO - PROCESS | 7965 | |9;json-stringify-tinderbox;68;67;66;67;68;67;68;68;67;67 08:59:36 INFO - PROCESS | 7965 | |10;stanford-crypto-aes;81;82;90;90;89;84;82;81;82;84 08:59:36 INFO - PROCESS | 7965 | |11;stanford-crypto-ccm;116;123;113;128;111;111;117;114;122;120 08:59:36 INFO - PROCESS | 7965 | |12;stanford-crypto-pbkdf2;139;129;140;138;140;129;142;137;140;138 08:59:36 INFO - PROCESS | 7965 | |13;stanford-crypto-sha256-iterative;66;67;66;67;66;67;65;67;65;68 08:59:36 INFO - PROCESS | 7965 | __end_tp_report 08:59:36 INFO - PROCESS | 7965 | __start_cc_report 08:59:36 INFO - PROCESS | 7965 | _x_x_mozilla_cycle_collect,922 08:59:36 INFO - PROCESS | 7965 | __end_cc_report 08:59:36 INFO - PROCESS | 7965 | __startTimestamp1453741176592__endTimestamp 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | ------- Summary: start ------- 08:59:36 INFO - PROCESS | 7965 | Number of tests: 14 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.03 (2.7%) stddev-sans-first:3.21 08:59:36 INFO - PROCESS | 7965 | Values: 111.0 112.0 105.0 112.0 112.0 112.0 113.0 113.0 105.0 110.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:154.50 stddev:18.72 (12.1%) stddev-sans-first:19.85 08:59:36 INFO - PROCESS | 7965 | Values: 146.0 124.0 159.0 165.0 128.0 153.0 156.0 126.0 174.0 124.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 08:59:36 INFO - PROCESS | 7965 | Values: 160.0 160.0 159.0 161.0 161.0 163.0 160.0 159.0 162.0 162.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#3] audio-fft Cycles:10 Average:90.80 Median:74.50 stddev:34.15 (45.8%) stddev-sans-first:35.61 08:59:36 INFO - PROCESS | 7965 | Values: 73.0 74.0 74.0 159.0 75.0 76.0 74.0 75.0 152.0 76.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:22.06 (23.0%) stddev-sans-first:22.80 08:59:36 INFO - PROCESS | 7965 | Values: 96.0 95.0 144.0 96.0 98.0 97.0 143.0 97.0 96.0 139.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:59:36 INFO - PROCESS | 7965 | Values: 109.0 109.0 109.0 109.0 108.0 108.0 109.0 109.0 109.0 109.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:59:36 INFO - PROCESS | 7965 | Values: 146.0 145.0 146.0 146.0 147.0 146.0 146.0 145.0 145.0 146.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 08:59:36 INFO - PROCESS | 7965 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.17 (2.1%) stddev-sans-first:1.13 08:59:36 INFO - PROCESS | 7965 | Values: 57.0 56.0 55.0 55.0 55.0 56.0 57.0 56.0 56.0 53.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 08:59:36 INFO - PROCESS | 7965 | Values: 68.0 67.0 66.0 67.0 68.0 67.0 68.0 68.0 67.0 67.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:3.72 (4.4%) stddev-sans-first:3.72 08:59:36 INFO - PROCESS | 7965 | Values: 81.0 82.0 90.0 90.0 89.0 84.0 82.0 81.0 82.0 84.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:118.50 stddev:5.64 (4.8%) stddev-sans-first:5.96 08:59:36 INFO - PROCESS | 7965 | Values: 116.0 123.0 113.0 128.0 111.0 111.0 117.0 114.0 122.0 120.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:139.50 stddev:4.54 (3.3%) stddev-sans-first:4.77 08:59:36 INFO - PROCESS | 7965 | Values: 139.0 129.0 140.0 138.0 140.0 129.0 142.0 137.0 140.0 138.0 08:59:36 INFO - PROCESS | 7965 | 08:59:36 INFO - PROCESS | 7965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 08:59:36 INFO - PROCESS | 7965 | Values: 66.0 67.0 66.0 67.0 66.0 67.0 65.0 67.0 65.0 68.0 08:59:36 INFO - PROCESS | 7965 | -------- Summary: end -------- 08:59:36 INFO - PROCESS | 7965 | 08:59:37 INFO - TEST-INFO | 7965: exit 0 08:59:37 INFO - TEST-OK | kraken | took 58654ms 08:59:37 INFO - TEST-START | v8_7 08:59:37 INFO - operating with platform_type : linux_ 08:59:37 INFO - Initialising browser for v8_7 test... 08:59:37 INFO - TEST-INFO | started process 8212 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6vmSPT/profile http://localhost:36485/getInfo.html) 08:59:41 INFO - PROCESS | 8212 | __metrics Screen width/height:1600/1200 08:59:41 INFO - PROCESS | 8212 | colorDepth:24 08:59:41 INFO - PROCESS | 8212 | Browser inner width/height: 1024/697 08:59:41 INFO - PROCESS | 8212 | __metrics 08:59:41 INFO - PROCESS | 8212 | 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:59:41 INFO - PROCESS | 8212 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:59:42 INFO - TEST-INFO | 8212: exit 0 08:59:42 INFO - Browser initialized. 08:59:42 INFO - Running cycle 1/1 for v8_7 test... 08:59:42 INFO - TEST-INFO | started process 8293 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6vmSPT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:54 INFO - PROCESS | 8293 | RSS: Main: 148029440 08:59:54 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | Cycle 1(1): loaded http://localhost:36485/tests/v8_7/run.html (next: http://localhost:36485/tests/v8_7/run.html) 09:00:16 INFO - PROCESS | 8293 | RSS: Main: 602767360 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | __start_tp_report 09:00:16 INFO - PROCESS | 8293 | _x_x_mozilla_page_load 09:00:16 INFO - PROCESS | 8293 | _x_x_mozilla_page_load_details 09:00:16 INFO - PROCESS | 8293 | |i|pagename|runs| 09:00:16 INFO - PROCESS | 8293 | |0;Richards;167.0843776106934 09:00:16 INFO - PROCESS | 8293 | |1;DeltaBlue;190.29495718363464 09:00:16 INFO - PROCESS | 8293 | |2;Encrypt;280.3476310625175 09:00:16 INFO - PROCESS | 8293 | |3;Decrypt;5306.878306878307 09:00:16 INFO - PROCESS | 8293 | |4;RayTrace;1123.5955056179776 09:00:16 INFO - PROCESS | 8293 | |5;Earley;793.6507936507936 09:00:16 INFO - PROCESS | 8293 | |6;Boyer;12444.444444444445 09:00:16 INFO - PROCESS | 8293 | |7;RegExp;42020 09:00:16 INFO - PROCESS | 8293 | |8;Splay;624.8439450686642 09:00:16 INFO - PROCESS | 8293 | |9;NavierStokes;4822.115384615385 09:00:16 INFO - PROCESS | 8293 | __end_tp_report 09:00:16 INFO - PROCESS | 8293 | __startTimestamp1453741216876__endTimestamp 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | ------- Summary: start ------- 09:00:16 INFO - PROCESS | 8293 | Number of tests: 10 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | [#0] Richards Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 09:00:16 INFO - PROCESS | 8293 | Values: 167.1 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | [#1] DeltaBlue Cycles:1 Average:190.29 Median:190.29 stddev:0.00 (0.0%) 09:00:16 INFO - PROCESS | 8293 | Values: 190.3 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 09:00:16 INFO - PROCESS | 8293 | Values: 280.3 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | [#3] Decrypt Cycles:1 Average:5306.88 Median:5306.88 stddev:0.00 (0.0%) 09:00:16 INFO - PROCESS | 8293 | Values: 5306.9 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | [#4] RayTrace Cycles:1 Average:1123.60 Median:1123.60 stddev:0.00 (0.0%) 09:00:16 INFO - PROCESS | 8293 | Values: 1123.6 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 09:00:16 INFO - PROCESS | 8293 | Values: 793.7 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 09:00:16 INFO - PROCESS | 8293 | Values: 12444.4 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | [#7] RegExp Cycles:1 Average:42020.00 Median:42020.00 stddev:0.00 (0.0%) 09:00:16 INFO - PROCESS | 8293 | Values: 42020.0 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | [#8] Splay Cycles:1 Average:624.84 Median:624.84 stddev:0.00 (0.0%) 09:00:16 INFO - PROCESS | 8293 | Values: 624.8 09:00:16 INFO - PROCESS | 8293 | 09:00:16 INFO - PROCESS | 8293 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 09:00:16 INFO - PROCESS | 8293 | Values: 4822.1 09:00:16 INFO - PROCESS | 8293 | -------- Summary: end -------- 09:00:16 INFO - PROCESS | 8293 | 09:00:17 INFO - TEST-INFO | 8293: exit 0 09:00:17 INFO - TEST-OK | v8_7 | took 40124ms 09:00:17 INFO - SUITE-END | took 1211s 09:00:17 INFO - Completed test suite (00:20:11) 09:00:17 INFO - Working with test: dromaeo_css 09:00:17 INFO - Generating results file: dromaeo_css 09:00:17 INFO - Working with test: kraken 09:00:17 INFO - Generating results file: kraken 09:00:17 INFO - javascript benchmark 09:00:17 INFO - Working with test: v8_7 09:00:17 INFO - Generating results file: v8_7 09:00:17 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:00:17 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 09:00:17 INFO - process_Request line: dromaeo_css 6714.94 graph.html#tests=[[72,1,35]] 09:00:17 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:00:17 INFO - process_Request line: kraken 1496.40 graph.html#tests=[[232,1,35]] 09:00:17 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:00:17 INFO - process_Request line: v8_7 19855.27 graph.html#tests=[[230,1,35]] 09:00:17 INFO - RETURN: dromaeo_css: 6714.94 09:00:17 INFO - RETURN: kraken: 1496.40 09:00:17 INFO - RETURN: v8_7: 19855.27 09:00:17 INFO - javascript benchmark 09:00:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3145.9685403145963, 3153.7792354535186, 3164.794288371256, 3169.4295026895165, 3204.919877003075, 5060.139776238039, 5060.772265248063, 5077.593792496601, 5096.490350964907, 5097.413797413298, 5111.795528178868, 5119.411267704215, 5166.638335316529, 5175.482451754822, 5178.792848286073, 4536.841210557631, 4659.464161621406, 4707.388039554853, 4789.880252993686, 4830.758462076882, 4662.230731929245, 4749.976250118744, 4776.47458779534, 4791.904161916759, 4904.215325547913, 4666.463356713971, 4733.053389322149, 4752.453467851206, 4753.714777113384, 4755.643326750507, 4665.836695715634, 4691.530846915315, 4702.905941881178, 4731.172044892164, 4756.952430475721, 4608.354830323758, 4674.065186962621, 4678.298255261704, 4691.507391723854, 4703.270992996091, 5000.2499625056535, 5064.2403639454005, 5077.26379674945, 5097.2608971699265, 5097.7960881564695, 5564.4713752193475, 5570.442955704438, 5579.414161513064, 5584.888302233973, 5585.497305242548, 5470.7264636768, 5610.887782244373, 5616.129499927477, 5620.718964051781, 5624.437556244384, 5153.845384638429, 5247.212918062283, 5309.41596424393, 5337.0, 5337.572994160497, 5707.058335374617, 5715.742791574389, 5716.056850619684, 5740.225069615632, 5749.626274292241, 5496.1755736639825, 5509.338879334426, 5519.724013799294, 5534.4742249486235, 5545.584081193846, 5459.235707001023, 5509.807156749494, 5544.0575102232715, 5551.555875529948, 5576.888462230814, 5504.889902201933, 5532.640378375393, 5536.390996990328, 5554.972330118941, 5570.888582228333, 5511.889762204733, 5513.2005859150195, 5523.7790488380815, 5538.058530049821, 5540.9168862467095, 4151.356539736345, 4227.0, 4246.893827654333, 4275.1022285319805, 4309.525952145262, 3843.9615603843604, 3861.8455261789213, 3874.903127421837, 3894.6884249259992, 3900.6099390061336, 5143.7685304161405, 5144.511271429283, 5150.845474635767, 5156.4070131935305, 5156.845294641167, 5410.998965191452, 5501.449855014546, 5507.531859791882, 5556.138798486241, 5644.604877658525, 5162.845114646567, 5165.199394093846, 5167.844964651066, 5176.0, 5189.506996835295, 4736.100140973204, 4736.95263047372, 4738.265568836836, 4773.0453909218295, 4782.067496838084, 5684.005299072645, 5754.395788442237, 5774.133879918046, 5847.736851841677, 5876.676782776988, 5493.505584497414, 5493.862653433536, 5525.972370138124, 5526.032944234663, 5534.695591742493, 5645.266115405136, 5729.914051289317, 5731.971340143273, 5732.57005724564, 5733.2260144881575, 5433.510984011458, 5437.32033495813, 5439.102548079522, 5454.318210223722, 5509.586780991362, 5463.371712252982, 5467.45325467466, 5475.2334673145, 5497.752601133038, 5519.917201241904, 5328.547073498796, 5348.025931637546, 5393.811216607557, 5418.376886658085, 5448.0, 5449.700266485382, 5485.753141108739, 5486.725663716878, 5487.451254874481, 5517.972410137923, 5334.386545547157, 5346.652467589594, 5349.705766182898, 5354.223637572608, 5399.865003374947, 5307.389650190277, 5329.600279978939, 5404.081306177881, 5417.620766546304, 5437.8368648940595, 5339.759710812945, 5393.298871146726, 5396.352437707344, 5397.568194544506, 5412.0], "unit": "score", "name": "dojo.html", "value": 5116.4479160413475}, {"lowerIsBetter": false, "replicates": [516.6254465512502, 526.1896679114162, 529.5578192209505, 541.1287826599178, 542.3248056170069, 27309.86345068277, 27763.305917352052, 35169.47245791315, 35771.10572235695, 35837.46243806338, 38058.8097059515, 38313.616863831354, 38410.0, 38497.807510962404, 38571.80714096432, 8455.069942306342, 8635.39552231344, 8639.00651425088, 8649.09184535624, 8650.13498650133, 8379.95810020952, 8472.534010629444, 8505.31957443403, 8507.61715722794, 8536.061033286334, 8515.276201522847, 8600.268977136919, 8776.166264204921, 8824.985126710446, 8827.691030813923, 8678.522681252529, 8755.956220218923, 8760.299176065899, 8772.254358379545, 8773.605187766565, 8610.311175105977, 8700.564971751388, 8738.956305218433, 8743.781405464852, 8746.212840844291, 38838.22323553541, 39298.41052384216, 39334.409983850266, 39358.40962385567, 39370.8188754335, 3116.1897906544464, 3169.4611915974338, 3259.3318369734384, 3654.506641603376, 3850.4224366344993, 27656.86171569129, 27717.168484945283, 28181.718182818113, 28227.15318540447, 28920.27699307513, 3710.239400922804, 3726.4782930389765, 3780.0360907968566, 3808.638179372983, 3958.8218530166214, 210119.0, 216138.0, 216449.9177504118, 216609.0, 216733.0, 55171.0, 56242.43757562372, 61073.0, 62428.375716243165, 64516.67741661262, 61277.38722612806, 61672.38327616756, 61709.69145154246, 61931.690341548005, 62006.0, 11552.6534203974, 11646.94176529112, 11649.941750291195, 11667.824982625267, 11677.59128430518, 8594.226519613265, 8836.513991730388, 9217.400868943498, 9479.668211612561, 9507.904920950841, 20318.492037699176, 20549.691754623393, 20561.97190140517, 20582.912563115653, 20608.0, 8212.876806847902, 8323.923535818885, 8324.29243514296, 8519.829603407898, 8588.699395521251, 985.4284514981293, 1007.8913195484907, 1031.8194315994672, 1080.8540846985713, 1124.398446830958, 28809.27976800555, 28864.121366361647, 28898.42203155925, 28969.0, 29268.414631707674, 1010.6412223660642, 1051.1275641217771, 1054.2040759226734, 1089.0525243038448, 1134.1040577943497, 15067.698646027018, 16212.837871621134, 16476.42332518356, 16508.587285317724, 16728.58178545522, 462167.0, 464871.0, 465696.0, 465828.0, 466030.0, 49264.50735492599, 49749.50250497449, 49770.75114624404, 49802.75098624556, 49825.50174498281, 1334.759743246225, 1339.77223871942, 1342.7180292138564, 1349.3455673998103, 1452.7457694903349, 26788.0, 28334.71665283321, 28659.713402865706, 30172.54741178928, 31732.20669483189, 43149.78425107854, 44183.77908110568, 48147.27779083387, 49419.0, 49880.25179622381, 332138.0, 332855.0, 337371.0, 337773.0, 337777.0, 35864.641353587176, 38213.0, 41769.734539818055, 42181.78909105557, 42421.15157696891, 36871.63128368789, 42045.0, 42486.5751342495, 42520.57479425166, 43495.0, 35677.46483802693, 35730.10674733153, 36044.27911441809, 40508.79745601253, 41592.58407415887, 35200.47199292064, 36034.352510834266, 36898.26203475969, 36959.63040369562, 37127.44308835315, 36126.0, 36421.63578364289, 36534.8173259132, 37889.0, 38674.226515470094, 31344.843275783474, 32791.50812737763, 33186.17034574155, 39574.0, 40932.59067409407, 28795.42409151847, 29026.854865726382, 29107.708922911348, 29578.0, 29676.851615742646], "unit": "score", "name": "ext.html", "value": 18540.463730760912}, {"lowerIsBetter": false, "replicates": [365.98536058557653, 367.25630598038987, 369.97595156314844, 372.6590169994455, 373.48832100022975, 13261.801072983913, 13412.26232557209, 15531.301091450883, 17209.483715488524, 18155.09224538771, 14796.556103316918, 14884.925575372135, 15045.473408430707, 15046.24768761563, 15604.375824967015, 5259.973700131503, 5477.20580515825, 5479.945200547983, 5480.205370221315, 5483.314585676791, 3954.4463775071513, 4093.6111069448357, 5369.919451208235, 5423.674579525222, 5635.070213414781, 5716.394979947719, 5821.417858214187, 5823.505002074829, 5827.737751801179, 5829.213056237418, 5837.387074357195, 5943.375945525744, 5963.403659634046, 5973.731182096816, 5977.4022597740095, 4873.683210591335, 5073.2643766654, 5076.695398276115, 5268.341457317835, 5276.657017293864, 12317.938410307981, 12487.937560312232, 15037.548873533811, 18693.813061869478, 18701.906490467598, 2094.1414020251623, 2107.2835236019673, 2112.8732276063483, 2152.4834039830484, 2241.820654347648, 9029.729108126767, 9301.674441394518, 9363.157315841607, 9370.765730856714, 9403.200727938134, 1756.262369804685, 1803.7835459744783, 1811.1759149586906, 1844.7601811764384, 1855.5082903030707, 49271.0, 49408.258876117245, 49848.0, 53548.196777048375, 55678.0, 9831.213502919749, 10033.19734421259, 10130.0, 10173.389596624227, 10208.744781380525, 13139.934300328438, 13250.801237981437, 13251.337433128305, 13258.204507729568, 13260.0, 6643.933560664428, 6658.6337751424135, 6695.564788288746, 6725.66371681414, 6772.72909083641, 6180.721867515973, 6185.876282474325, 6206.0, 6215.9378406216265, 6220.160278362454, 4438.4451943507065, 4461.063176732858, 4469.888252793706, 4489.0, 4509.864704058883, 1715.313874450205, 1754.2632094520332, 1769.716845304745, 1846.7783865936174, 1862.7891870284152, 901.197933838884, 976.6825781621002, 993.5876611206413, 1030.896910308963, 1065.3661071662348, 15770.526884193492, 16207.594810129842, 16591.336346546243, 16844.157792110345, 17048.744268835977, 888.5868071346725, 927.2859897878595, 927.3045216087934, 928.6146249306462, 996.1632228927735, 8781.517016564023, 8995.730128096167, 9023.323250756088, 9080.137386948229, 9112.0, 547501.0, 554962.0, 556061.0, 586386.0, 588759.0, 59953.40046599478, 60598.0, 63253.68373158105, 70150.64924675344, 70946.0, 947.3984020147257, 1020.2042406922612, 1047.77870913662, 1092.8306112552566, 1138.8234823602354, 13930.373133209232, 15001.474948376754, 15079.924600376928, 15153.393864245307, 15384.923075384551, 31677.366452670358, 32376.0, 32792.0, 32831.0, 33132.0, 41850.581494185884, 42000.789996049825, 42252.57747422486, 42353.57646423496, 42863.57136428721, 6966.756163534455, 7125.8574828502105, 7175.461840362098, 7266.2007179211305, 7363.116426028697, 3450.1202193440513, 5571.66570005801, 7732.806679833049, 8621.180987806149, 10297.3821570706, 8691.348148888732, 8886.555672216235, 8938.68714594986, 9128.634854606007, 9178.036306187754, 8858.73423797287, 8910.86633700508, 9027.18090629519, 9239.815203695754, 9259.86110208334, 9448.811023779348, 9483.66807161746, 9676.177524910461, 9856.112949834549, 9935.751606209613, 7055.506114572136, 7162.173645720308, 7296.96351518239, 7434.936810030601, 7459.291367320096, 9079.409838360485, 9384.57769400365, 9933.801323973625, 10054.89945100569, 10069.345492542961], "unit": "score", "name": "jquery.html", "value": 7846.685370233082}, {"lowerIsBetter": false, "replicates": [1292.6186774901403, 1454.8108745863037, 1472.6980968901373, 1635.2804765903002, 1793.0496836676566, 6742.325767423261, 7322.340989310961, 7427.034485516882, 7456.0307160069115, 7465.0, 7411.0736157980255, 7417.740379086733, 7441.255874412556, 7490.288422599858, 7509.511881727698, 1935.2549268531645, 1985.2852972929734, 2279.4415368234804, 2301.8618882867, 2303.3205204464725, 2219.145628932856, 2292.610256256432, 2292.7275362173987, 2293.0598454633605, 2293.919712810052, 2171.9457013574706, 2188.3763127508664, 2205.6250437425674, 2209.248855389167, 2223.4663680716594, 2163.664631982045, 2168.6530155175174, 2174.195547647365, 2194.692743015979, 2230.7992280694652, 2169.39257008038, 2215.4129155773735, 2220.034285085993, 2226.476777957179, 2244.2930476899887, 7551.509151905108, 7623.504472209289, 7626.733064342777, 7630.8855367169535, 7631.465797394185, 4411.823527058914, 4552.271636538171, 4556.612687921497, 4558.544145585448, 4571.154336447735, 2888.3501212227293, 2895.5367141257298, 2931.92670183245, 2939.8824047038306, 3055.9694403055905, 995.2386424385351, 1002.7192386131894, 1031.8091153136693, 1040.266612038511, 1048.1405247696891, 10557.736056598647, 10585.470726463645, 10586.788264234749, 10588.947055264674, 10601.575936962512, 4050.9594904051173, 4120.237756015147, 4129.256733787887, 4199.37009448579, 4264.722793018444, 9057.18485336323, 9096.363254572116, 9100.681476148304, 9114.954425227965, 9121.22469590079, 4522.29904364824, 4532.9320060199125, 4557.886052848706, 4558.88602784933, 4583.381243532147, 4135.0902801383645, 4138.813753381105, 4146.709730318909, 4148.62662360383, 4163.604457576525, 3377.155711072232, 3432.2105915639045, 3594.0655429587973, 3643.981780091083, 3734.3091528067393, 1193.8209268609778, 1194.42070595761, 1199.4782269712703, 1211.497228650118, 1216.0, 1024.0271741845277, 1047.1361127070197, 1047.5547892145808, 1186.9525218991316, 1347.5620423362445, 7009.509334346547, 7112.182099058571, 7126.643667816588, 7149.0706208192605, 7149.642517874189, 1106.8948449897248, 1110.134095405585, 1126.245415571569, 1129.3449799116493, 1138.4478527913955, 5543.390227075019, 5618.747156377973, 5619.662820230717, 5620.325560932714, 5621.325440947113, 9083.772905677279, 9139.131782480654, 9341.159295663423, 9351.953240233755, 9462.668806591737, 9220.631174752934, 9248.075192480832, 9336.719898403058, 9360.765980850398, 9363.204127649089, 6823.590584564942, 6930.5099403628465, 6957.373836354753, 7136.678849451787, 7187.856242875113, 7040.0847889774, 7121.501494895308, 7122.287771222836, 7130.928690713234, 7134.928650713634, 7864.960675196817, 8002.0, 8054.556999364857, 8055.919440805751, 8062.596870156586, 8040.5979701015885, 8243.629036693483, 8346.457480263764, 8365.707200247962, 8370.581470926307, 6872.072270243653, 6898.758543450955, 6907.481938854707, 6925.826854328682, 6931.5097254090615, 6339.5562310637815, 6452.645104519296, 6457.773977910751, 6897.827554311182, 7261.273872612696, 6637.568558043712, 6663.666816659051, 6726.529142959946, 6782.423494002867, 6799.320067993359, 6538.771143010162, 6548.1814773153355, 6565.540412171103, 6587.571807832475, 6734.225564060196, 6414.358564143548, 6444.9355506444335, 6456.257530384066, 6459.160309159779, 6460.806175814733, 6255.78104766331, 6355.713992870425, 6419.4864410846085, 6427.775027874189, 6428.839279017875, 6220.0, 6247.0629405589525, 6268.404501572343, 6275.34108918557, 6279.2464904209955], "unit": "score", "name": "mootools.html", "value": 4366.7033901094765}, {"lowerIsBetter": false, "replicates": [322.34724682517896, 325.6076427904375, 327.355110432448, 333.8864785972769, 335.5252317970071, 5833.679147646878, 5858.20914176586, 5903.704814759256, 5916.7041647917595, 5941.197938278331, 5553.666779993203, 5663.660180389169, 5669.404712505179, 5846.795362162326, 5862.589618726691, 4489.079738653568, 4504.662150338721, 4512.684112112153, 4522.660800439964, 4531.524189960056, 4316.9136617267795, 4519.796609152596, 4528.117017181651, 4530.886727831814, 4535.750533720644, 4355.847545335914, 4382.452193475816, 4465.88352911772, 4483.820647174109, 4496.505384407713, 4429.889252768674, 4457.799399027035, 4478.529754375809, 4479.753613551254, 4481.058977614704, 3924.038610540436, 3929.7249192556533, 3931.4889064421727, 3935.74417662851, 3941.113249518864, 5467.480589344046, 5550.000999820031, 5559.16612508127, 5570.3315602127595, 5581.302337207849, 5182.611304152204, 5184.922226166611, 5185.196294574347, 5191.870203244911, 5193.948060519384, 6149.13912052313, 6155.969220153871, 6158.261008678943, 6161.7535298588, 6174.104754810573, 4335.046289816235, 4341.652667786601, 4345.956540434587, 4346.0, 4347.869563913087, 6300.87398252037, 6430.7106180222, 6443.516736244754, 6444.484441244689, 6444.774432894873, 4433.8669839904205, 4440.933385999213, 4441.600255976978, 4446.0, 4448.644108471314, 4494.52807455219, 4499.482559505699, 4503.0, 4503.279475283939, 4505.81976720934, 5155.175171972542, 5158.896822063538, 5175.870603234949, 5177.275181474596, 5179.378474583074, 6106.084087386927, 6201.0, 6220.129181914535, 6229.688515574203, 6233.875322493524, 1578.9605259868595, 1602.543275166572, 1602.543275166572, 1606.8232494425604, 1609.629785149422, 1038.2628333882876, 1040.6097713357492, 1062.4209805655937, 1078.8867168947304, 1084.7559299157626, 5909.23179986599, 5917.053271476543, 5930.495907847795, 5931.9406805931385, 5938.435848594377, 6388.39310265524, 6389.456896163878, 6392.936070639327, 6401.935980640227, 6421.325760795049, 5694.373618901917, 5793.826185214451, 5803.071508558611, 5892.587518873637, 5911.881762364728, 3441.5698037745283, 3470.965290347064, 3473.1664400543686, 3478.6347433519622, 3481.6518348165487, 6584.473242140617, 6599.208095028532, 6611.305812889577, 6612.801615951529, 6614.140161778938, 6392.904106438407, 6580.80257592273, 6618.768343107968, 6625.900611490832, 6636.104125942936, 6760.459163266927, 6832.624205668736, 6840.794776156723, 6843.452523797984, 6848.760293389807, 6432.6140431572385, 6472.996685513753, 6481.740730370732, 6484.675766211576, 6493.902591461037, 6278.309385967631, 6391.552591318749, 6393.104965304768, 6410.326915673973, 6411.262704788823, 6740.090087838079, 6744.932550674431, 6745.055692202997, 6745.460363170836, 6751.122354093936, 4387.583179597933, 4400.955990440055, 4423.270160423623, 4424.225760491837, 4426.0, 6360.06713569239, 6389.9041514376395, 6457.128287681103, 6460.709268083042, 6469.77355792545, 6284.245890492987, 6287.2140982377205, 6294.874102518015, 6304.085907543289, 6305.770374776875, 6240.219972503437, 6277.0, 6288.27684816252, 6293.685315734104, 6304.65324407162, 6056.939430605637, 6160.630362178284, 6162.661053642093, 6167.044108163242, 6195.2255968004, 6301.590396624205, 6306.054091886253, 6319.494440444845, 6330.683465826598, 6333.050042493663, 6184.196054512884, 6184.628922264678, 6186.752529898754, 6188.566800324114, 6193.473554747897], "unit": "score", "name": "prototype.html", "value": 4702.700835971521}, {"lowerIsBetter": false, "replicates": [714.8606021825743, 792.615581443, 811.1807074854395, 815.522919092331, 834.4867906237665, 12675.49298028079, 12884.355782210887, 12924.353782310895, 12936.094473386867, 12979.156354836929, 11219.887801121986, 11230.66308010759, 11240.606578769744, 11261.831072533918, 11269.492872820743, 646.5861848417017, 657.9013148027786, 792.2948575767572, 796.0646240667207, 807.4590024683476, 788.9013873265842, 790.7074382478492, 798.2416704131069, 798.4769975665919, 801.935845132388, 691.7163962775263, 845.1464021338462, 851.940364174508, 853.6116067189445, 854.2567965869702, 695.2942763095463, 821.6918655504186, 836.5775283481834, 837.2297486312607, 837.7528629054443, 608.1698481572621, 613.3927411862269, 613.5214532664529, 613.5858295650418, 613.9416755408274, 12123.6362909112, 12161.087918406067, 12179.939100304442, 12198.39008049594, 12248.632541023784, 11124.888751112467, 11700.941495292554, 11733.4719937603, 12006.399680015964, 12306.630801075982, 9623.759406014835, 9691.176250018756, 9732.710056334688, 9950.850737238947, 9970.0, 3496.17839807645, 3526.717862570988, 3582.408902531079, 3598.6941110005682, 3676.6690997810324, 46491.0, 46748.130074796965, 47032.76483617594, 47206.0, 47995.28007079862, 9685.612575496902, 9687.951560242294, 9698.0, 9764.072413120743, 9810.0, 15053.698926021418, 15344.923275383775, 15398.769018464733, 15408.0, 15412.0, 7101.9289807102305, 7103.218645948941, 7106.502544821813, 7139.750108746169, 7310.597917114504, 3954.54522729884, 3965.206958608232, 4058.9594104059174, 4096.078382364004, 4117.958820411817, 2913.839738814386, 2952.9704702953127, 2956.9408611827644, 2956.9556456653168, 2959.5116805727243, 516.2256615077384, 533.6237952243658, 541.4504278157673, 543.570579242394, 543.6167501911143, 608.6135304081852, 619.1641284266294, 642.9774957876452, 646.4505170604948, 657.5298661456985, 7819.804504887424, 7830.765077047698, 7905.418208291397, 7932.603369831485, 8056.154103819132, 453.2770231480783, 497.84815631232095, 600.9308929473079, 612.3386742318286, 641.4419455074022, 3631.6913062389995, 3707.6107008763693, 3738.5887552369218, 3850.6534411903062, 3885.747426417274, 56268.0, 58219.417805822246, 58251.12623310654, 58336.70831645815, 58394.0, 50144.247836282484, 51845.0, 51865.0, 52261.2160817588, 52522.0, 45279.0, 46602.766986164854, 47075.0, 47707.52292477031, 47732.284015739795, 7498.700051997859, 7631.732889348847, 7634.0, 7641.808954776175, 7755.379569634303, 33901.0, 34687.65312346945, 34868.128296792784, 35497.46753798747, 37850.24299514049, 42564.36153457639, 42787.57212427836, 43759.343609845244, 43846.49228061683, 44384.77807610941, 10514.842277365693, 10729.933206440544, 10767.192460565333, 10953.288036277616, 11034.613788517363, 11860.14817751581, 11905.047596192111, 12189.939050304693, 12198.268103913793, 12348.876511234772, 10740.946295268473, 11001.944990274997, 11074.39090850011, 11336.489857956576, 11750.353730544903, 10645.520951557044, 10680.679579612624, 11019.889801101886, 11032.724181895517, 11032.724181895517, 8467.195616416431, 9691.224702023963, 10074.19406447497, 10546.419946902686, 10565.577376904837, 8456.154384561494, 8808.295336373203, 9065.138811812867, 9472.242220622471, 9782.41305521671, 8123.5532045738055, 8948.73153805387, 9373.625054997996, 9557.90442095598, 9568.425894446356], "unit": "score", "name": "yui.html", "value": 5997.012495380206}], "name": "dromaeo_css", "value": 6714.935827601511}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 112.0, 112.0, 112.0, 113.0, 113.0, 105.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [146.0, 124.0, 159.0, 165.0, 128.0, 153.0, 156.0, 126.0, 174.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 159.0, 161.0, 161.0, 163.0, 160.0, 159.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 74.0, 159.0, 75.0, 76.0, 74.0, 75.0, 152.0, 76.0], "unit": "score", "name": "audio-fft", "value": 90.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 144.0, 96.0, 98.0, 97.0, 143.0, 97.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 108.0, 108.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 55.0, 55.0, 56.0, 57.0, 56.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 90.0, 90.0, 89.0, 84.0, 82.0, 81.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [116.0, 123.0, 113.0, 128.0, 111.0, 111.0, 117.0, 114.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.5}, {"lowerIsBetter": true, "replicates": [139.0, 129.0, 140.0, 138.0, 140.0, 129.0, 142.0, 137.0, 140.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 65.0, 67.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1496.4000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "Richards", "value": 211.28247000000007}, {"lowerIsBetter": false, "replicates": [190.29495718363464], "unit": "score", "name": "DeltaBlue", "value": 347.4500900000001}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5306.878306878307], "unit": "score", "name": "Decrypt", "value": 50.15773579262209}, {"lowerIsBetter": false, "replicates": [1123.5955056179776], "unit": "score", "name": "RayTrace", "value": 658.5902099999998}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [42020.0], "unit": "score", "name": "RegExp", "value": 21.67979533555451}, {"lowerIsBetter": false, "replicates": [624.8439450686642], "unit": "score", "name": "Splay", "value": 130.4181638361638}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19855.268753862838}]} 09:00:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19855.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1496.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6714.94"}}} 09:00:18 INFO - Return code: 0 09:00:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:00:18 INFO - # TBPL SUCCESS # 09:00:18 INFO - Running post-action listener: _resource_record_post_action 09:00:18 INFO - Running post-run listener: _resource_record_post_run 09:00:19 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 549675008; Read time: 0; Write time: 536024 09:00:19 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244269056; Read time: 0; Write time: 296376 09:00:19 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 301527040; Read time: 0; Write time: 239168 09:00:19 INFO - Running post-run listener: _upload_blobber_files 09:00:19 INFO - Blob upload gear active. 09:00:19 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:00:19 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:00:19 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:00:19 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:00:19 INFO - (blobuploader) - INFO - Open directory for files ... 09:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:20 INFO - (blobuploader) - INFO - Done attempting. 09:00:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:00:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:00:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:21 INFO - (blobuploader) - INFO - Done attempting. 09:00:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:21 INFO - Return code: 0 09:00:21 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:00:21 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c46adb1b5ab61295f2fa2eabe933f146c52c854b640db7d9db0983f70a4fc0f569a0e1e7094534efc9018bd325ed28adbc98d3e83539245de83b6e807d79af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11c73a05c203950c0f2f85ce4dbe3d42e9d3dd3bb2530b29fd45ca6e0c34b73a1fe927764c2f3daba2e439e0a8e0e9dd688e8cc1eddcaaa2d339ae79761fb16e"} 09:00:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:00:21 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:00:21 INFO - Contents: 09:00:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c46adb1b5ab61295f2fa2eabe933f146c52c854b640db7d9db0983f70a4fc0f569a0e1e7094534efc9018bd325ed28adbc98d3e83539245de83b6e807d79af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11c73a05c203950c0f2f85ce4dbe3d42e9d3dd3bb2530b29fd45ca6e0c34b73a1fe927764c2f3daba2e439e0a8e0e9dd688e8cc1eddcaaa2d339ae79761fb16e"} 09:00:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:21 INFO - Copying logs to upload dir... 09:00:21 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:00:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.741116 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-25 09:00:21.222688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 09:00:21.225897) ========= 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=82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c46adb1b5ab61295f2fa2eabe933f146c52c854b640db7d9db0983f70a4fc0f569a0e1e7094534efc9018bd325ed28adbc98d3e83539245de83b6e807d79af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11c73a05c203950c0f2f85ce4dbe3d42e9d3dd3bb2530b29fd45ca6e0c34b73a1fe927764c2f3daba2e439e0a8e0e9dd688e8cc1eddcaaa2d339ae79761fb16e"} 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.011337 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c46adb1b5ab61295f2fa2eabe933f146c52c854b640db7d9db0983f70a4fc0f569a0e1e7094534efc9018bd325ed28adbc98d3e83539245de83b6e807d79af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11c73a05c203950c0f2f85ce4dbe3d42e9d3dd3bb2530b29fd45ca6e0c34b73a1fe927764c2f3daba2e439e0a8e0e9dd688e8cc1eddcaaa2d339ae79761fb16e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 09:00:21.250670) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:00:21.250988) ========= 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=82e07478c745e68b1fe4678a000001bc-1453739858.576205-70281456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:00:21.335381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 09:00:21.335721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 09:00:21.336010) ========= ========= Total master_lag: 0.29 =========