builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1453827553.12 results: success (0) buildid: 20160125030203 builduid: fa9411aaf741499a9b7142874c71568d revision: 67c66c2878aed17ae3096d7db483ddbb2293c503 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.122887) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.123241) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.123527) ========= 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=d2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006432 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.172407) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.172690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.208162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.208403) ========= 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=d2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.262228) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.262506) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.262862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.263148) ========= 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=d2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-26 08:59:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-01-26 08:59:13 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094709 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.369717) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.370007) ========= 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=d2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020852 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.419021) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.419540) ========= 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=d2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-26 08:59:13,700 truncating revision to first 12 chars 2016-01-26 08:59:13,700 Setting DEBUG logging. 2016-01-26 08:59:13,700 attempt 1/10 2016-01-26 08:59:13,700 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-26 08:59:13,935 unpacking tar archive at: mozilla-central-67c66c2878ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522371 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.955965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:13.956319) ========= 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=d2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 67c66c2878aed17ae3096d7db483ddbb2293c503 program finished with exit code 0 elapsedTime=0.003973 script_repo_revision: '67c66c2878aed17ae3096d7db483ddbb2293c503' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:14.007558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:14.008163) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 08:59:14.019203) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-01-26 08:59:14.019486) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:59:14 INFO - MultiFileLogger online at 20160126 08:59:14 in /builds/slave/test-pgo 08:59:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:59:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:59:14 INFO - {'append_to_log': False, 08:59:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:59:14 INFO - 'blob_upload_branch': 'Firefox', 08:59:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:59:14 INFO - 'branch': 'Firefox', 08:59:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:14 INFO - 'config_files': ('talos/linux_config.py',), 08:59:14 INFO - 'default_actions': ('clobber', 08:59:14 INFO - 'read-buildbot-config', 08:59:14 INFO - 'download-and-extract', 08:59:14 INFO - 'populate-webroot', 08:59:14 INFO - 'create-virtualenv', 08:59:14 INFO - 'install', 08:59:14 INFO - 'run-tests'), 08:59:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:14 INFO - 'download_minidump_stackwalk': True, 08:59:14 INFO - 'download_symbols': 'ondemand', 08:59:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:14 INFO - 'installer_path': 'installer.exe', 08:59:14 INFO - 'log_level': 'info', 08:59:14 INFO - 'log_name': 'talos', 08:59:14 INFO - 'log_to_console': True, 08:59:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:59:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:59:14 INFO - 'opt_config_files': (), 08:59:14 INFO - 'pip_index': False, 08:59:14 INFO - 'sps_profile': False, 08:59:14 INFO - 'sps_profile_interval': 0, 08:59:14 INFO - 'suite': 'dromaeojs-e10s', 08:59:14 INFO - 'system_bits': '32', 08:59:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:14 INFO - 'title': 'talos-linux64-ix-043', 08:59:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:14 INFO - 'use_talos_json': True, 08:59:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:59:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:14 INFO - 'work_dir': 'build'} 08:59:14 INFO - ##### 08:59:14 INFO - ##### Running clobber step. 08:59:14 INFO - ##### 08:59:14 INFO - Running pre-action listener: _resource_record_pre_action 08:59:14 INFO - Running main action method: clobber 08:59:14 INFO - rmtree: /builds/slave/test-pgo/build 08:59:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:59:15 INFO - Running post-action listener: _resource_record_post_action 08:59:15 INFO - ##### 08:59:15 INFO - ##### Running read-buildbot-config step. 08:59:15 INFO - ##### 08:59:15 INFO - Running pre-action listener: _resource_record_pre_action 08:59:15 INFO - Running main action method: read_buildbot_config 08:59:15 INFO - Using buildbot properties: 08:59:15 INFO - { 08:59:15 INFO - "project": "", 08:59:15 INFO - "product": "firefox", 08:59:15 INFO - "script_repo_revision": "production", 08:59:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:59:15 INFO - "repository": "", 08:59:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 08:59:15 INFO - "buildid": "20160125030203", 08:59:15 INFO - "stage_platform": "linux64-pgo", 08:59:15 INFO - "basedir": "/builds/slave/test-pgo", 08:59:15 INFO - "nightly_build": "True", 08:59:15 INFO - "buildnumber": 330, 08:59:15 INFO - "slavename": "talos-linux64-ix-043", 08:59:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:59:15 INFO - "platform": "ubuntu64_hw", 08:59:15 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 08:59:15 INFO - "branch": "mozilla-central", 08:59:15 INFO - "repo_path": "mozilla-central", 08:59:15 INFO - "revision": "67c66c2878aed17ae3096d7db483ddbb2293c503", 08:59:15 INFO - "pgo_build": "True", 08:59:15 INFO - "builduid": "fa9411aaf741499a9b7142874c71568d", 08:59:15 INFO - "slavebuilddir": "test" 08:59:15 INFO - } 08:59: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:59:15 INFO - Running post-action listener: _resource_record_post_action 08:59:15 INFO - ##### 08:59:15 INFO - ##### Running download-and-extract step. 08:59:15 INFO - ##### 08:59:15 INFO - Running pre-action listener: _resource_record_pre_action 08:59:15 INFO - Running main action method: download_and_extract 08:59:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:59: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:59:15 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:59: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:59: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:59: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:59: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:59:28 INFO - Downloaded 1448 bytes. 08:59:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:59:28 INFO - Using the following test package requirements: 08:59:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:59:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:59:28 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:59:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:28 INFO - u'jsshell-linux-x86_64.zip'], 08:59:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:59:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:59:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:59:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:59:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:59:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:59:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:59:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:59:28 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:59:28 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:59:28 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:59:28 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:59:28 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:59:28 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:59:33 INFO - Downloaded 22494448 bytes. 08:59:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:59:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:59:34 INFO - Return code: 0 08:59:34 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:59: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:59:34 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:59:34 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:59:34 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:59:34 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:59:34 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:59:38 INFO - Downloaded 22494448 bytes. 08:59:38 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:59:38 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:59:40 INFO - Return code: 0 08:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:40 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:59:40 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:59:40 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:59:40 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:59:40 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:59:41 INFO - Downloaded 10706572 bytes. 08:59:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:59:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:59:41 INFO - Return code: 0 08:59: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:59:41 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:59:41 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:59:41 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:59:41 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:59:41 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:59:42 INFO - Downloaded 55990395 bytes. 08:59:42 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:59:42 INFO - mkdir: /builds/slave/test-pgo/properties 08:59:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:59:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:59:42 INFO - Contents: 08:59:42 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:59:42 INFO - Running post-action listener: _resource_record_post_action 08:59:42 INFO - Running post-action listener: set_extra_try_arguments 08:59:42 INFO - ##### 08:59:42 INFO - ##### Running populate-webroot step. 08:59:42 INFO - ##### 08:59:42 INFO - Running pre-action listener: _resource_record_pre_action 08:59:42 INFO - Running main action method: populate_webroot 08:59:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:42 INFO - '--tppagecycles', 08:59:42 INFO - '7'], 08:59:42 INFO - 'tests': ['tsvgm']}}, 08:59:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:59:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:59:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:59:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:59:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:59:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:42 INFO - 'talos_options': ['--e10s'], 08:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:42 INFO - 'tests': ['damp', 'tps']}, 08:59:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:42 INFO - 'talos_options': ['--e10s'], 08:59:42 INFO - 'tests': ['damp', 'tps']}, 08:59:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:59:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:42 INFO - 'other': {'tests': ['a11yr', 08:59:42 INFO - 'ts_paint', 08:59:42 INFO - 'tpaint', 08:59:42 INFO - 'sessionrestore', 08:59:42 INFO - 'sessionrestore_no_auto_restore']}, 08:59:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:59:42 INFO - 'tests': ['a11yr', 08:59:42 INFO - 'ts_paint', 08:59:42 INFO - 'tpaint', 08:59:42 INFO - 'sessionrestore', 08:59:42 INFO - 'sessionrestore_no_auto_restore']}, 08:59:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:59:42 INFO - 'tests': ['a11yr', 08:59:42 INFO - 'ts_paint', 08:59:42 INFO - 'tpaint', 08:59:42 INFO - 'sessionrestore', 08:59:42 INFO - 'sessionrestore_no_auto_restore']}, 08:59:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:59:42 INFO - 'tests': ['a11yr', 08:59:42 INFO - 'ts_paint', 08:59:42 INFO - 'tpaint', 08:59:42 INFO - 'sessionrestore', 08:59:42 INFO - 'sessionrestore_no_auto_restore']}, 08:59:42 INFO - 'other_l64': {'tests': ['a11yr', 08:59:42 INFO - 'ts_paint', 08:59:42 INFO - 'tpaint', 08:59:42 INFO - 'sessionrestore', 08:59:42 INFO - 'sessionrestore_no_auto_restore']}, 08:59:42 INFO - 'other_nol64': {'tests': ['a11yr', 08:59:42 INFO - 'ts_paint', 08:59:42 INFO - 'tpaint', 08:59:42 INFO - 'sessionrestore', 08:59:42 INFO - 'sessionrestore_no_auto_restore']}, 08:59:42 INFO - 'svgr': {'tests': ['tsvgx', 08:59:42 INFO - 'tsvgr_opacity', 08:59:42 INFO - 'tart', 08:59:42 INFO - 'tscrollx', 08:59:42 INFO - 'cart']}, 08:59:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:59:42 INFO - 'tests': ['tsvgx', 08:59:42 INFO - 'tsvgr_opacity', 08:59:42 INFO - 'tart', 08:59:42 INFO - 'tscrollx', 08:59:42 INFO - 'cart']}, 08:59:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:42 INFO - 'tests': ['tp5o']}, 08:59:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:42 INFO - 'talos_options': ['--e10s'], 08:59:42 INFO - 'tests': ['tp5o']}, 08:59:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:42 INFO - 'talos_options': ['--xperf_path', 08:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:42 INFO - 'tests': ['tp5n']}, 08:59:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:42 INFO - 'talos_options': ['--e10s', 08:59:42 INFO - '--xperf_path', 08:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:42 INFO - 'tests': ['tp5n']}}, 08:59:42 INFO - 'talos.zip': {'path': '', 08:59:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:42 INFO - Running post-action listener: _resource_record_post_action 08:59:42 INFO - ##### 08:59:42 INFO - ##### Running create-virtualenv step. 08:59:42 INFO - ##### 08:59:42 INFO - Running pre-action listener: _resource_record_pre_action 08:59:42 INFO - Running main action method: create_virtualenv 08:59:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:59:42 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:59:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:59:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:42 INFO - Using real prefix '/usr' 08:59:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:59:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:45 INFO - Installing pip.................done. 08:59:45 INFO - Return code: 0 08:59:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90878d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1869840>, '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 0x17d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6b60>, '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': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', '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:59:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:59:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:59:45 INFO - Using env: {'DISPLAY': ':0', 08:59:45 INFO - 'HOME': '/home/cltbld', 08:59:45 INFO - 'LANG': 'en_US.UTF-8', 08:59:45 INFO - 'LANGUAGE': 'en_US:en', 08:59:45 INFO - 'LOGNAME': 'cltbld', 08:59:45 INFO - 'MAIL': '/var/mail/cltbld', 08:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:45 INFO - 'MOZ_NO_REMOTE': '1', 08:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:45 INFO - 'NO_EM_RESTART': '1', 08:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:59:45 INFO - 'PWD': '/builds/slave/test-pgo', 08:59:45 INFO - 'SHELL': '/bin/bash', 08:59:45 INFO - 'SHLVL': '1', 08:59:45 INFO - 'TERM': 'linux', 08:59:45 INFO - 'TMOUT': '86400', 08:59:45 INFO - 'USER': 'cltbld', 08:59:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', 08:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:45 INFO - '_': '/tools/buildbot/bin/python'} 08:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:59:45 INFO - Cleaning up... 08:59:45 INFO - Return code: 0 08:59:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90878d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1869840>, '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 0x17d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6b60>, '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': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', '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:59:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:59:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:59:45 INFO - Using env: {'DISPLAY': ':0', 08:59:45 INFO - 'HOME': '/home/cltbld', 08:59:45 INFO - 'LANG': 'en_US.UTF-8', 08:59:45 INFO - 'LANGUAGE': 'en_US:en', 08:59:45 INFO - 'LOGNAME': 'cltbld', 08:59:45 INFO - 'MAIL': '/var/mail/cltbld', 08:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:45 INFO - 'MOZ_NO_REMOTE': '1', 08:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:45 INFO - 'NO_EM_RESTART': '1', 08:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:59:45 INFO - 'PWD': '/builds/slave/test-pgo', 08:59:45 INFO - 'SHELL': '/bin/bash', 08:59:45 INFO - 'SHLVL': '1', 08:59:45 INFO - 'TERM': 'linux', 08:59:45 INFO - 'TMOUT': '86400', 08:59:45 INFO - 'USER': 'cltbld', 08:59:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', 08:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:45 INFO - '_': '/tools/buildbot/bin/python'} 08:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:45 INFO - Downloading/unpacking psutil>=0.7.1 08:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:47 INFO - Installing collected packages: psutil 08:59:47 INFO - Running setup.py install for psutil 08:59:47 INFO - building 'psutil._psutil_linux' extension 08:59:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:59:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:59:48 INFO - building 'psutil._psutil_posix' extension 08:59:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:59:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:59:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:48 INFO - Successfully installed psutil 08:59:48 INFO - Cleaning up... 08:59:48 INFO - Return code: 0 08:59:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90878d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1869840>, '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 0x17d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6b60>, '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': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', '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:59:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:59:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:59:48 INFO - Using env: {'DISPLAY': ':0', 08:59:48 INFO - 'HOME': '/home/cltbld', 08:59:48 INFO - 'LANG': 'en_US.UTF-8', 08:59:48 INFO - 'LANGUAGE': 'en_US:en', 08:59:48 INFO - 'LOGNAME': 'cltbld', 08:59:48 INFO - 'MAIL': '/var/mail/cltbld', 08:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:48 INFO - 'MOZ_NO_REMOTE': '1', 08:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:48 INFO - 'NO_EM_RESTART': '1', 08:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:59:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:59:48 INFO - 'SHELL': '/bin/bash', 08:59:48 INFO - 'SHLVL': '1', 08:59:48 INFO - 'TERM': 'linux', 08:59:48 INFO - 'TMOUT': '86400', 08:59:48 INFO - 'USER': 'cltbld', 08:59:48 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', 08:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:48 INFO - '_': '/tools/buildbot/bin/python'} 08:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:59:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:59:50 INFO - Installing collected packages: mozsystemmonitor 08:59:50 INFO - Running setup.py install for mozsystemmonitor 08:59:50 INFO - Successfully installed mozsystemmonitor 08:59:50 INFO - Cleaning up... 08:59:50 INFO - Return code: 0 08:59:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90878d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1869840>, '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 0x17d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6b60>, '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': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', '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:59:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:59:50 INFO - Using env: {'DISPLAY': ':0', 08:59:50 INFO - 'HOME': '/home/cltbld', 08:59:50 INFO - 'LANG': 'en_US.UTF-8', 08:59:50 INFO - 'LANGUAGE': 'en_US:en', 08:59:50 INFO - 'LOGNAME': 'cltbld', 08:59:50 INFO - 'MAIL': '/var/mail/cltbld', 08:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:50 INFO - 'MOZ_NO_REMOTE': '1', 08:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:50 INFO - 'NO_EM_RESTART': '1', 08:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:59:50 INFO - 'PWD': '/builds/slave/test-pgo', 08:59:50 INFO - 'SHELL': '/bin/bash', 08:59:50 INFO - 'SHLVL': '1', 08:59:50 INFO - 'TERM': 'linux', 08:59:50 INFO - 'TMOUT': '86400', 08:59:50 INFO - 'USER': 'cltbld', 08:59:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', 08:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:50 INFO - '_': '/tools/buildbot/bin/python'} 08:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:59:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:59:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:59:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:53 INFO - Downloading docopt-0.6.1.tar.gz 08:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:59:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:59:53 INFO - Running setup.py install for blobuploader 08:59:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:59:53 INFO - Running setup.py install for requests 08:59:53 INFO - Running setup.py install for docopt 08:59:53 INFO - Successfully installed blobuploader requests docopt 08:59:53 INFO - Cleaning up... 08:59:53 INFO - Return code: 0 08:59:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:53 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 0x7f90878d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1869840>, '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 0x17d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6b60>, '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': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', '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:59:53 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:59:53 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:59:53 INFO - Using env: {'DISPLAY': ':0', 08:59:53 INFO - 'HOME': '/home/cltbld', 08:59:53 INFO - 'LANG': 'en_US.UTF-8', 08:59:53 INFO - 'LANGUAGE': 'en_US:en', 08:59:53 INFO - 'LOGNAME': 'cltbld', 08:59:53 INFO - 'MAIL': '/var/mail/cltbld', 08:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:53 INFO - 'MOZ_NO_REMOTE': '1', 08:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:53 INFO - 'NO_EM_RESTART': '1', 08:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 08:59:53 INFO - 'SHELL': '/bin/bash', 08:59:53 INFO - 'SHLVL': '1', 08:59:53 INFO - 'TERM': 'linux', 08:59:53 INFO - 'TMOUT': '86400', 08:59:53 INFO - 'USER': 'cltbld', 08:59:53 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', 08:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:53 INFO - '_': '/tools/buildbot/bin/python'} 08:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:59:54 INFO - Running setup.py (path:/tmp/pip-APJkcm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:59:54 INFO - Running setup.py (path:/tmp/pip-TfiXoT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:59:54 INFO - Running setup.py (path:/tmp/pip-z5aBMm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:59:54 INFO - Running setup.py (path:/tmp/pip-Nt9vqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:59:54 INFO - Running setup.py (path:/tmp/pip-KZYMm_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:59:54 INFO - Running setup.py (path:/tmp/pip-gwQjs0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:59:54 INFO - Running setup.py (path:/tmp/pip-njtOFx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:59:54 INFO - Running setup.py (path:/tmp/pip-ElJfzJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:59:54 INFO - Running setup.py (path:/tmp/pip-SLHBpT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:59:54 INFO - Running setup.py (path:/tmp/pip-eXhKCN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:59:54 INFO - Running setup.py (path:/tmp/pip-bnsZA3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:59:54 INFO - Running setup.py (path:/tmp/pip-fVLjJ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:59:55 INFO - Running setup.py (path:/tmp/pip-LOxjGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:59:55 INFO - Running setup.py (path:/tmp/pip-V_7dV7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:59:55 INFO - Running setup.py (path:/tmp/pip-74a8ZJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:59:55 INFO - Running setup.py (path:/tmp/pip-LFN4O9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:59:55 INFO - Running setup.py (path:/tmp/pip-e9k2cV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:59:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:59:55 INFO - Running setup.py install for manifestparser 08:59:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:59:55 INFO - Running setup.py install for mozcrash 08:59:55 INFO - Running setup.py install for mozdebug 08:59:55 INFO - Running setup.py install for mozdevice 08:59:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:59:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:59:55 INFO - Running setup.py install for mozfile 08:59:55 INFO - Running setup.py install for mozhttpd 08:59:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Running setup.py install for mozinfo 08:59:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Running setup.py install for mozInstall 08:59:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Running setup.py install for mozleak 08:59:56 INFO - Running setup.py install for mozlog 08:59:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Running setup.py install for moznetwork 08:59:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Running setup.py install for mozprocess 08:59:56 INFO - Running setup.py install for mozprofile 08:59:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Running setup.py install for mozrunner 08:59:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:59:56 INFO - Running setup.py install for mozscreenshot 08:59:56 INFO - Running setup.py install for moztest 08:59:57 INFO - Running setup.py install for mozversion 08:59:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:59:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:59:57 INFO - Cleaning up... 08:59:57 INFO - Return code: 0 08:59:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90878d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1869840>, '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 0x17d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6b60>, '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': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', '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:59:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:59:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:59:57 INFO - Using env: {'DISPLAY': ':0', 08:59:57 INFO - 'HOME': '/home/cltbld', 08:59:57 INFO - 'LANG': 'en_US.UTF-8', 08:59:57 INFO - 'LANGUAGE': 'en_US:en', 08:59:57 INFO - 'LOGNAME': 'cltbld', 08:59:57 INFO - 'MAIL': '/var/mail/cltbld', 08:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:57 INFO - 'MOZ_NO_REMOTE': '1', 08:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:57 INFO - 'NO_EM_RESTART': '1', 08:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:59:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:59:57 INFO - 'SHELL': '/bin/bash', 08:59:57 INFO - 'SHLVL': '1', 08:59:57 INFO - 'TERM': 'linux', 08:59:57 INFO - 'TMOUT': '86400', 08:59:57 INFO - 'USER': 'cltbld', 08:59:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', 08:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:57 INFO - '_': '/tools/buildbot/bin/python'} 08:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:59:57 INFO - Running setup.py (path:/tmp/pip-8h51X5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 08:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:59:57 INFO - Running setup.py (path:/tmp/pip-44uf_U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:59:57 INFO - Running setup.py (path:/tmp/pip-fmyk1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:59:57 INFO - Running setup.py (path:/tmp/pip-acaWyl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:59:57 INFO - Running setup.py (path:/tmp/pip-7aKedj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 08:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:59:57 INFO - Running setup.py (path:/tmp/pip-gdkVg_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 08:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:59:57 INFO - Running setup.py (path:/tmp/pip-IzjOtV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 08:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:59:57 INFO - Running setup.py (path:/tmp/pip-YOSAwY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:59:57 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:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:59:57 INFO - Running setup.py (path:/tmp/pip-dn35Mg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 08:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:59:58 INFO - Running setup.py (path:/tmp/pip-X6Qd3X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:59:58 INFO - Running setup.py (path:/tmp/pip-KMU891-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 08:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:59:58 INFO - Running setup.py (path:/tmp/pip-SEk_F_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 08:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:59:58 INFO - Running setup.py (path:/tmp/pip-A2odhV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 08:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:59:58 INFO - Running setup.py (path:/tmp/pip-2rhjVn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 08:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:59:58 INFO - Running setup.py (path:/tmp/pip-uODiV6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 08:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:59:58 INFO - Running setup.py (path:/tmp/pip-OtEbOe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 08:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:59:58 INFO - Running setup.py (path:/tmp/pip-4NjdIB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:59:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:00 INFO - Downloading blessings-1.6.tar.gz 09:00:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:00:00 INFO - Installing collected packages: blessings 09:00:00 INFO - Running setup.py install for blessings 09:00:00 INFO - Successfully installed blessings 09:00:00 INFO - Cleaning up... 09:00:00 INFO - Return code: 0 09:00:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:00:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:00:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:00:00 INFO - Reading from file tmpfile_stdout 09:00:00 INFO - Current package versions: 09:00:00 INFO - argparse == 1.2.1 09:00:00 INFO - blessings == 1.6 09:00:00 INFO - blobuploader == 1.2.4 09:00:00 INFO - docopt == 0.6.1 09:00:00 INFO - manifestparser == 1.1 09:00:00 INFO - mozInstall == 1.12 09:00:00 INFO - mozcrash == 0.16 09:00:00 INFO - mozdebug == 0.1 09:00:00 INFO - mozdevice == 0.48 09:00:00 INFO - mozfile == 1.2 09:00:00 INFO - mozhttpd == 0.7 09:00:00 INFO - mozinfo == 0.9 09:00:00 INFO - mozleak == 0.1 09:00:00 INFO - mozlog == 3.1 09:00:00 INFO - moznetwork == 0.27 09:00:00 INFO - mozprocess == 0.22 09:00:00 INFO - mozprofile == 0.28 09:00:00 INFO - mozrunner == 6.11 09:00:00 INFO - mozscreenshot == 0.1 09:00:00 INFO - mozsystemmonitor == 0.0 09:00:00 INFO - moztest == 0.7 09:00:00 INFO - mozversion == 1.4 09:00:00 INFO - psutil == 3.1.1 09:00:00 INFO - requests == 1.2.3 09:00:00 INFO - wsgiref == 0.1.2 09:00:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90878d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1869840>, '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 0x17d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6b60>, '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': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', '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 09:00:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:00:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:00:00 INFO - Using env: {'DISPLAY': ':0', 09:00:00 INFO - 'HOME': '/home/cltbld', 09:00:00 INFO - 'LANG': 'en_US.UTF-8', 09:00:00 INFO - 'LANGUAGE': 'en_US:en', 09:00:00 INFO - 'LOGNAME': 'cltbld', 09:00:00 INFO - 'MAIL': '/var/mail/cltbld', 09:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:00 INFO - 'MOZ_NO_REMOTE': '1', 09:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:00 INFO - 'NO_EM_RESTART': '1', 09:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:00:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:00:00 INFO - 'SHELL': '/bin/bash', 09:00:00 INFO - 'SHLVL': '1', 09:00:00 INFO - 'TERM': 'linux', 09:00:00 INFO - 'TMOUT': '86400', 09:00:00 INFO - 'USER': 'cltbld', 09:00:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', 09:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:00 INFO - '_': '/tools/buildbot/bin/python'} 09:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:00:01 INFO - Cleaning up... 09:00:01 INFO - Return code: 0 09:00:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90878d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1869840>, '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 0x17d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6b60>, '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': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', '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 09:00:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:00:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:00:01 INFO - Using env: {'DISPLAY': ':0', 09:00:01 INFO - 'HOME': '/home/cltbld', 09:00:01 INFO - 'LANG': 'en_US.UTF-8', 09:00:01 INFO - 'LANGUAGE': 'en_US:en', 09:00:01 INFO - 'LOGNAME': 'cltbld', 09:00:01 INFO - 'MAIL': '/var/mail/cltbld', 09:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:01 INFO - 'MOZ_NO_REMOTE': '1', 09:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:01 INFO - 'NO_EM_RESTART': '1', 09:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:00:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:00:01 INFO - 'SHELL': '/bin/bash', 09:00:01 INFO - 'SHLVL': '1', 09:00:01 INFO - 'TERM': 'linux', 09:00:01 INFO - 'TMOUT': '86400', 09:00:01 INFO - 'USER': 'cltbld', 09:00:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', 09:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:01 INFO - '_': '/tools/buildbot/bin/python'} 09:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:01 INFO - Downloading/unpacking jsonschema 09:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:00:03 INFO - Downloading/unpacking functools32 (from jsonschema) 09:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:00:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:00:03 INFO - warning: no files found matching '*.txt' 09:00:03 INFO - no previously-included directories found matching 'build' 09:00:03 INFO - no previously-included directories found matching 'dist' 09:00:03 INFO - no previously-included directories found matching '.git*' 09:00:03 INFO - Installing collected packages: jsonschema, functools32 09:00:03 INFO - Running setup.py install for functools32 09:00:03 INFO - warning: no files found matching '*.txt' 09:00:03 INFO - no previously-included directories found matching 'build' 09:00:03 INFO - no previously-included directories found matching 'dist' 09:00:03 INFO - no previously-included directories found matching '.git*' 09:00:03 INFO - Successfully installed jsonschema functools32 09:00:03 INFO - Cleaning up... 09:00:03 INFO - Return code: 0 09:00:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:00: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')]} 09:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90878d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1869840>, '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 0x17d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6b60>, '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': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', '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 09:00:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:00:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:00:03 INFO - Using env: {'DISPLAY': ':0', 09:00:03 INFO - 'HOME': '/home/cltbld', 09:00:03 INFO - 'LANG': 'en_US.UTF-8', 09:00:03 INFO - 'LANGUAGE': 'en_US:en', 09:00:03 INFO - 'LOGNAME': 'cltbld', 09:00:03 INFO - 'MAIL': '/var/mail/cltbld', 09:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:03 INFO - 'MOZ_NO_REMOTE': '1', 09:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:03 INFO - 'NO_EM_RESTART': '1', 09:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:00:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:00:03 INFO - 'SHELL': '/bin/bash', 09:00:03 INFO - 'SHLVL': '1', 09:00:03 INFO - 'TERM': 'linux', 09:00:03 INFO - 'TMOUT': '86400', 09:00:03 INFO - 'USER': 'cltbld', 09:00:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', 09:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:03 INFO - '_': '/tools/buildbot/bin/python'} 09:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:03 INFO - Downloading/unpacking flake8 09:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:00:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:00:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:00:06 INFO - no previously-included directories found matching 'docs/_build' 09:00:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:00:06 INFO - Running setup.py install for pep8 09:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:00:06 INFO - no previously-included directories found matching 'docs/_build' 09:00:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:00:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:00:06 INFO - Cleaning up... 09:00:06 INFO - Return code: 0 09:00:06 INFO - Running post-action listener: _resource_record_post_action 09:00:06 INFO - Running post-action listener: _start_resource_monitoring 09:00:06 INFO - Starting resource monitoring. 09:00:06 INFO - ##### 09:00:06 INFO - ##### Running install step. 09:00:06 INFO - ##### 09:00:06 INFO - Running pre-action listener: _resource_record_pre_action 09:00:06 INFO - Running main action method: install 09:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:00:06 INFO - Reading from file tmpfile_stdout 09:00:06 INFO - Detecting whether we're running mozinstall >=1.0... 09:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:00:06 INFO - Reading from file tmpfile_stdout 09:00:06 INFO - Output received: 09:00:06 INFO - Usage: mozinstall [options] installer 09:00:06 INFO - Options: 09:00:06 INFO - -h, --help show this help message and exit 09:00:06 INFO - -d DEST, --destination=DEST 09:00:06 INFO - Directory to install application into. [default: 09:00:06 INFO - "/builds/slave/test-pgo"] 09:00:06 INFO - --app=APP Application being installed. [default: firefox] 09:00:06 INFO - mkdir: /builds/slave/test-pgo/build/application 09:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:00:22 INFO - Reading from file tmpfile_stdout 09:00:22 INFO - Output received: 09:00:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:00:22 INFO - Running post-action listener: _resource_record_post_action 09:00:22 INFO - ##### 09:00:22 INFO - ##### Running run-tests step. 09:00:22 INFO - ##### 09:00:22 INFO - Running pre-action listener: _resource_record_pre_action 09:00:22 INFO - Running main action method: run_tests 09:00:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:00:22 INFO - Python 2.7.3 09:00:22 INFO - Return code: 0 09:00:22 INFO - grabbing minidump binary from tooltool 09:00: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')]} 09:00:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1869840>, '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 0x17d66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:00:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:00:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:00:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:22 INFO - Return code: 0 09:00:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:00:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:00:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:00:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:00:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:00:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:00:23 INFO - Return code: 0 09:00:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 09:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:00:23 INFO - Using env: {'DISPLAY': ':0', 09:00:23 INFO - 'HOME': '/home/cltbld', 09:00:23 INFO - 'LANG': 'en_US.UTF-8', 09:00:23 INFO - 'LANGUAGE': 'en_US:en', 09:00:23 INFO - 'LOGNAME': 'cltbld', 09:00:23 INFO - 'MAIL': '/var/mail/cltbld', 09:00:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:00:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:23 INFO - 'MOZ_NO_REMOTE': '1', 09:00:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:23 INFO - 'NO_EM_RESTART': '1', 09:00:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:00:23 INFO - 'PWD': '/builds/slave/test-pgo', 09:00:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:00:23 INFO - 'SHELL': '/bin/bash', 09:00:23 INFO - 'SHLVL': '1', 09:00:23 INFO - 'TERM': 'linux', 09:00:23 INFO - 'TMOUT': '86400', 09:00:23 INFO - 'USER': 'cltbld', 09:00:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897', 09:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:23 INFO - '_': '/tools/buildbot/bin/python'} 09:00:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:00:24 INFO - mozversion application_buildid: 20160125030203 09:00:24 INFO - mozversion application_changeset: 67c66c2878aed17ae3096d7db483ddbb2293c503 09:00:24 INFO - mozversion application_display_name: Nightly 09:00:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:24 INFO - mozversion application_name: Firefox 09:00:24 INFO - mozversion application_remotingname: firefox 09:00:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:00:24 INFO - mozversion application_vendor: Mozilla 09:00:24 INFO - mozversion application_version: 46.0a1 09:00:24 INFO - mozversion platform_buildid: 20160125030203 09:00:24 INFO - mozversion platform_changeset: 67c66c2878aed17ae3096d7db483ddbb2293c503 09:00:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:00:24 INFO - mozversion platform_version: 46.0a1 09:00:24 INFO - using testdate: 1453827624 09:00:24 INFO - actual date: 1453827624 09:00:24 INFO - starting webserver on 'localhost:43574' 09:00:24 INFO - SUITE-START | Running 3 tests 09:00:24 INFO - TEST-START | dromaeo_css 09:00:24 INFO - operating with platform_type : linux_ 09:00:24 INFO - Initialising browser for dromaeo_css test... 09:00:24 INFO - TEST-INFO | started process 25732 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPpomX1/profile http://localhost:43574/getInfo.html) 09:00:28 INFO - PROCESS | 25732 | 09:00:28 INFO - PROCESS | 25732 | (process:25814): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:00:28 INFO - PROCESS | 25732 | __metrics Screen width/height:1600/1200 09:00:28 INFO - PROCESS | 25732 | colorDepth:24 09:00:28 INFO - PROCESS | 25732 | Browser inner width/height: 1024/697 09:00:28 INFO - PROCESS | 25732 | __metrics 09:00:29 INFO - PROCESS | 25732 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:00:29 INFO - TEST-INFO | 25732: exit 0 09:00:29 INFO - Browser initialized. 09:00:29 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:29 INFO - TEST-INFO | started process 25863 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPpomX1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:31 INFO - PROCESS | 25863 | 09:00:31 INFO - PROCESS | 25863 | (process:25920): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:00:41 INFO - PROCESS | 25863 | RSS: Main: 152174592 09:00:41 INFO - PROCESS | 25863 | 09:01:31 INFO - PROCESS | 25863 | 1453827691209 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] 09:03:40 INFO - PROCESS | 25863 | Cycle 1(1): loaded http://localhost:43574/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43574/tests/dromaeo/cssquery-ext.html) 09:03:41 INFO - PROCESS | 25863 | RSS: Main: 160436224 09:03:41 INFO - PROCESS | 25863 | 09:06:43 INFO - PROCESS | 25863 | Cycle 1(1): loaded http://localhost:43574/tests/dromaeo/cssquery-ext.html (next: http://localhost:43574/tests/dromaeo/cssquery-jquery.html) 09:06:43 INFO - PROCESS | 25863 | RSS: Main: 155242496 09:06:43 INFO - PROCESS | 25863 | 09:09:45 INFO - PROCESS | 25863 | Cycle 1(1): loaded http://localhost:43574/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43574/tests/dromaeo/cssquery-mootools.html) 09:09:46 INFO - PROCESS | 25863 | RSS: Main: 156516352 09:09:46 INFO - PROCESS | 25863 | 09:12:48 INFO - PROCESS | 25863 | Cycle 1(1): loaded http://localhost:43574/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43574/tests/dromaeo/cssquery-prototype.html) 09:12:48 INFO - PROCESS | 25863 | RSS: Main: 155238400 09:12:48 INFO - PROCESS | 25863 | 09:15:50 INFO - PROCESS | 25863 | Cycle 1(1): loaded http://localhost:43574/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43574/tests/dromaeo/cssquery-yui.html) 09:15:51 INFO - PROCESS | 25863 | RSS: Main: 154570752 09:15:51 INFO - PROCESS | 25863 | 09:18:54 INFO - PROCESS | 25863 | Cycle 1(1): loaded http://localhost:43574/tests/dromaeo/cssquery-yui.html (next: http://localhost:43574/tests/dromaeo/cssquery-dojo.html) 09:18:54 INFO - PROCESS | 25863 | RSS: Main: 158425088 09:18:54 INFO - PROCESS | 25863 | 09:18:54 INFO - PROCESS | 25863 | __start_tp_report 09:18:54 INFO - PROCESS | 25863 | _x_x_mozilla_page_load 09:18:54 INFO - PROCESS | 25863 | _x_x_mozilla_page_load_details 09:18:54 INFO - PROCESS | 25863 | |i|pagename|runs| 09:18:54 INFO - PROCESS | 25863 | |0;dojo.html;3252.6909943555365;3283.3269179818126;3312.801231926086;3319.1702074481386;3322.4019676458242;5234.8745019820735;5312.043832110228;5325.201219817024;5362.410134885165;5374.140137577989;5258.368995720519;5324.893502129965;5325;5378.946210537893;5394.271773310602;4965.801367945287;4979.975100124494;5022.773975171108;5111.386633603973;5114.028334616411;4965.3545039144865;5026.497350264981;5028.371453568304;5037.168867136918;5078.415982162043;4655.604273636745;4845.079434907357;4967.453580106186;4976.2286845539;4978.452370239271;4936.136176169192;4983.327250821165;4985;5005.299258103868;5014.498550144993;4879.072976134523;4942.431620363633;4949.307097006422;4954.133026720346;5032.823851165228;5154;5178.378594568639;5182;5218.425973142951;5264.394594621629;5852.414758524156;5853.268341457318;5861.20873682056;5871.324797648283;5873.941260587425;5778.3354914184565;5883.17635531026;5884.352721200665;5903.763849446017;5907.202527658754;5419.972900135474;5433.320834895638;5438.265834112383;5441.347038355383;5486.780528778884;5881.676507792027;5882.499987501024;5888.205092312569;5893.381194974466;5894.263217097863;5649.265595472644;5656.547476201894;5666.886662266814;5670.376258611549;5671.6597004179885;5808.88382232353;5849.766009359578;5852.502537284378;5861.296644402613;5908.05471124618;5749.597528173072;5790.507806836466;5803.100519419497;5807.361190269067;5809.9419005809405;5613.242212301368;5676.290463692038;5775.740091695884;5778.971105144447;5792.565557583198;4370.104128653618;4382.605565499057;4388.934165987513;4400.779961001937;4418.116376724668;3961.9405708914387;3992.680585553207;3995.320795464778;4023.7786921719585;4026.7583944963394;5354.973225133927;5383.300170977748;5405.78376864921;5433.782648694087;5539.279893613804;5717.799877004368;5743;5769.74036168365;5776.68228247442;5787.536997040227;5338.225957236179;5389.730513474311;5405.567554595623;5421.1055175895535;5467.425920278393;4713.952860471351;4780.139574876486;4844.442889067732;4946.752662366939;4969.627277954168;5924.289085309791;5938.198343223696;5944.613600115892;5956.255468066492;5958.85102872423;5684.914726279192;5718.771249150153;5743.684097374685;5748.9425105748405;5755.510781583613;5893.823185304448;5923.851903702442;5934.821955341346;6001.90997135052;6026.939730602638;5737;5752.07966725322;5770.913436298375;5794.783095549982;5814.447627475383;5852.824415267549;5877.882442351214;5886.676232807236;5887.146363777314;5890.880732660781;5527.060399732136;5559.388467268516;5559.9444005561045;5669;5723.7996670116345;5653.010723123355;5677.8864422710485;5720.771169153188;5725.4560816724015;5725.599208055396;5494.395616482264;5589.413111623221;5605.383407825218;5621.184928185472;5623.409541998031;5571.0807716726285;5671.48956593892;5679.977604031149;5750.424957504216;5792.797252096157;5525.475079867406;5539.861503462445;5571.582131340247;5578.470045345685;5599.832005039855 09:18:54 INFO - PROCESS | 25863 | |1;ext.html;525.9586019681029;533.7510226070995;548.1394211088588;554.1881144123857;560.0171698668836;34608;35238.295234095334;35383.64616353836;35400.291994160136;35417.11457213571;38642.42036369457;38892;39036.414453783145;39043.804780976054;39061.414078788766;8377.49735015898;8527.616257268437;8544.23101920827;8569.571521423935;8576.785580360478;8266.214709602607;8392.328613710919;8427.83144337113;8552.828943421127;8618.310535157172;8591;8623.956880215621;8639.308855291561;8685.913140868573;8694.304455643565;8541.188587084218;8546.78633034176;8588.355873309527;8594.054653988056;8660.047394786632;8467.068622451525;8558.058613552505;8589;8625.309975202032;8650.956745216234;38313.616863831565;38512.614873851184;38643.227135457135;38708.612913870784;38731.22537549233;3305.190228394059;3322.4850148227065;3563.465480177968;3664.926701465982;3901.1027463683513;29115.272118197;29413.41173176546;29435.264118396997;30286;30550.69449305523;3911.3350730375905;3919.7844118573466;3939.5863434339267;4022.3363145081025;4106.260873042851;253533;254900;254994;256233;256458;54993.72503137459;55094.72452637791;55370.16944745832;55410.16884746651;56293.43706562964;59705.701471492364;60752.69623651853;60774;60870.0869486958;61468;11918.284902905853;11956.103292253116;11976.161668683282;12066.09504287182;12118.515259389525;9071.682491112779;9075.228605568469;9079.228265597367;9084.682036128836;9123.954380228057;18676.06619669011;18705.158267877978;18845.340413085476;19509.902450487658;19640;7583.696652133964;7756.689732410753;7816.374690024784;7855.057393112863;7860.174681658458;973.3332667123043;1005.3816902604846;1040.6877936618985;1068.257560995101;1070.3203465799274;28260.293492662437;28323.858380708378;28371;28691.2827179318;28829.27926801847;991.0832479956011;993.6373223773271;1011.4285428732743;1011.6307547745167;1058.3702696895334;14734.410623575151;15404;15606;15938.601534961486;16395.098269595048;327969;330050;330681;331823;333261;43917.341239881425;44200.115997679866;44654.776726116164;44670.77664611656;44801.10397792026;1310.0502135951358;1315.3423288355823;1323.5764555342198;1343.402186027228;1343.8588948160302;24914.25257242213;25941.610875837254;27442.862785685942;27487.17538473849;27797.722022780323;42267.5773242276;42332.36501452542;42366.152676946906;42578;42802.57197427986;246036;248792;249063;249121;249381;29798.702012979593;30538.236544086576;31114.68885311118;31131.221719456287;31384.215394614403;36081.45877811783;36396.63603364038;36962;37147.442788358734;37393.81303093576;33567.12035236767;33994.83002584971;34052.31895362128;34671.479927800596;35114.297714046086;33654.32393218519;34448.138796530286;34588.65411345854;34727.47908781421;34738.47892281567;34223.14442138966;34559.481607776404;34698.826505867306;35070;35178.64821351856;26276.343091422867;27593.724062759116;29246.853765731033;29470;29728.554071689374;22738.658920115882;22801.657975130056;23246.767532325135;24108.9907437281;24260 09:18:54 INFO - PROCESS | 25863 | |2;jquery.html;362.86936702786994;367.8657290089117;369.56945158889897;371.5949614919737;376.3507948788342;15351.69296614067;16340.591485212846;16788.916055419722;16821.915890420532;17924.193411296492;11154.10767138629;11295.774084518305;16630.251638676258;16731.749023764653;16746.330146794113;4806.134895718778;5123.948760512403;5127.769250383742;5133.435322114565;5148.279240906276;4739.881502962419;5020.272060551218;5068.315777370063;5069.569086627623;5070.5183007614405;3736.1967177056927;3916.608339166089;5352.357717073937;6106.908396374058;6123.11214873843;5417.756200970965;5475.288212532385;5479.945200547983;5483.451654834525;5554.444555544454;5307.363116426015;5307.495787900143;5351.2240725095035;5359.946400535984;5363.249145119687;12514.436850341757;13851.861481385258;18270;18663.44009679712;18776.71834922477;2213.524092320159;2220.920535324241;2252.4931890324547;2253.3352660964892;2291.8854057297235;8845.469271843709;8920.375573709844;8925.33060020501;9179.449233046038;9766.316357854954;1833.633273345323;1861.3299212283566;1864.8974306413143;1874.709420039896;1903.3909149072304;55182;56076;56772.432275677544;57617.42382576162;58413.12380314341;10223.386596804066;10316;10316.123129533924;10360.740981475372;10383.896161038445;13294.667633309246;13322.533711320057;13448.462061517625;13474.326283685776;13531.188128712309;6638;6737.831554211184;6901.309869013058;6950.096487456598;7014.649267536603;6354.523410744213;6358.427741503287;6439.9696048631995;6453.903191452132;6471.449926756279;4496.505384407713;4498.977505112453;4528.071745292207;4559.658025648089;4573;1877.9436616901241;1916.304070897266;1932.9710054349196;1941.2623203182982;1968.0848405491515;404.46004583880847;408.0349972315512;415.64047099258926;448.18206772640065;457.9587837094611;10092.013360160156;10821.513031913426;10855.891441085647;11009.559617615367;11244.437778111062;443.9289713645866;444.0918322031453;444.98887527812064;448.34317724533713;459.04518601309195;5923.585349025527;6096.72564734588;9151.222146117521;9702.951485242529;9879.259055570861;530476;534198;538292;549922;553748;71322;71340;71357;71557.64221178964;73193;1064.5635289531256;1093.9890601093887;1098.8846171152074;1102.5920409448556;1119.093534237254;14996.850031499982;15143.469978550698;15194.088354698311;15333.846661533242;15458.84541154574;32467.837660811543;33109;33792.831035845644;34355.4846677305;34575.82712086423;43988;44390.77804610956;44822.551774481835;45246.095078098915;47593.52406476029;6908.723651053901;6956.200036995608;6987.161540614956;7286.48994570375;7312.926870731225;10085.193184545073;10695.786084278427;10857.805641379284;10944.507497162806;11164.218504704593;9133.543322833964;9349.185169637505;9382.827146606674;9539.713808585753;9762.902370976199;8564.700235491728;9904;10043.849342260019;10080.84878726805;10299.3820370778;3085.336652619608;4137.048478849942;6765.391114799691;10399.376037437778;10439.478026098514;7349.77950661481;7625.275598818103;7632.885506717293;7661.88507172404;7761.456698031084;7146.3568278855155;9031.36780425364;10051.748706282402;10185.185185185019;10429.68710938673 09:18:54 INFO - PROCESS | 25863 | |3;mootools.html;1485.4578079001164;1497.7977972973645;1665.142451637407;1729.8183690712467;1796.802351741309;7709.190534993822;7822.726204582841;7858.646360913758;7909.564973926432;7919.366450683953;7906.723264685737;7927.048754149496;7952.840943181133;7974.840503189933;7995.840083198347;2239.731232252128;2265.1958554713087;2270.897809598572;2279.9658005129936;2294.357579877637;2205.195103787114;2215.6233440315186;2250.707408036953;2250.8762018089;2254.3124347074217;1923.7980012098737;1974.6445639784833;2262.8981695823727;2299.482616411311;2308.53829234153;2182.7817218278124;2215.213599172303;2236.474428509315;2239.473723674935;2241.2715867343177;2259.0850705464313;2266.614675505152;2266.909323627053;2282.44080200352;2300.4823914619246;7405.555666660018;7436.888446673304;7477.252274772479;7480.9251907480775;7495.850082998364;4590.150822097922;4690.061987602493;4700.388949436551;4706.858794236178;4710.952890471086;3005.774566907469;3011.713887180714;3132.9843350783326;3166.509191075387;3168.825714585697;934.5000424772782;947.1144479911236;953.9570719317647;1831.5878927241265;1857.229249861306;10576.68269951895;10645.414502202375;10674.786504269949;10714.357138571711;10738.30201036938;4041.939370909439;4061.2283666103344;4090.3250963591267;4092.0383709828166;4263.381809637585;8783.2095111439;8826.249768769727;8826.51454170014;8827.293816494664;8874.733757987271;4627.814887404534;4650.372199753057;4683.110209060268;4686.437627484655;4689.648276379286;4266.4240327556;4286.849960251377;4304.139172165579;4318.481782186095;4334.393184954109;3490.144914495914;3531.94702079469;3557.8221088945447;3569.6430356964615;3578.856845726194;1074.3446497636435;1078.3637653784149;1104;1117.022605220432;1131.4625552862324;977.1451623345974;1012.9189664826944;1046.5186014433293;1302.863199364072;1346.01068214862;7212.891806622905;7235.9507871358355;7331.633418329062;7344.412447004227;7362.44781641379;619.4486906653083;634.9206349206349;637.5537124013209;639.3159319528061;772.7874834420467;5372.785088596491;5504.972475137599;5713.74288157034;5734.799282025109;5767.134929760569;9525.904740952501;9526.85709714355;9682.128608425135;9842.75393115178;9898;9685.9031409685;9730.659426920023;9766.169875560516;9788.755281118029;9808.460534670661;7169.677364518505;7580;7614.466987310946;7626.54240745557;7638.236176382428;7330.486865919548;7386.2613738625705;7420.109586849612;7421.8144546386775;7435.367993720594;8367.497950123012;8432.957835210786;8568.057513673615;8599.183077607617;8611.48331100136;8505.23452889243;8687.39188256816;8687.478751274944;8724.083971182934;8726.476411415335;6873.4157596602845;7017.578945263301;7090.787276381717;7097.46768992338;7133.85732285341;7546.924530754842;7552.735654252075;7598.772036838904;7607.847843043219;7638.236176382317;6973.686184121828;7168.8924666129005;7176.210616832249;7266.273372662691;7313.488055836253;6834.726610935507;6897.544033738526;7022.192447868356;7041.929580704333;7060.576365417885;7136.964315178391;7255.129384473897;7255.419566434567;7303.8539229216185;7304;6345.175127233615;6513.967430163008;6516.543841931019;6522.315156908646;6526.738930442729;6623.966880165761;6654.201495820533;6722.092517510074;6724.831879202863;6735.393814556517 09:18:54 INFO - PROCESS | 25863 | |4;prototype.html;319.80491899941035;326.25776358783764;328.3859183327178;336.0674129291218;344.7621141412427;6131.7547298108075;6215.347388524202;6219.4713449356805;6233.2208473940755;6324.3991820776955;6134.815955521331;6205.751769929208;6234.968825155868;6257.4994000479965;6265.780697675582;4710.317004034413;4743.383360163191;4752.572268495826;4757.333973243749;4764.332993380929;4758.547937945889;4759.238521836507;4764.118638051954;4769.165396055694;4770.284457331393;4615.076984603076;4616.3537104805355;4639.628829693634;4707.764611769415;4716.858494245161;4645.442546894361;4649.116667833101;4655.2784318430695;4655.790489427984;4667.6732628716;4096.959030409687;4111.48606424197;4129.938050929209;4131.049858532524;4155.127423241123;5886.852828679274;5945.227120474354;5948.315943666447;5952.226210592638;5961.940380596182;5466.01611709892;5492.423295553949;5535.308086489189;5568.136938774496;5576.7211639417865;6580.736770529173;6598.406143447065;6610.438112760421;6615.37153970372;6616.966915165442;4597.448306203277;4618.930716039262;4622.930656040162;4623.30650402439;4629.120467111272;6643.767468138641;6817.99999999995;6826.829329266759;6909.550879192887;6912.965435172842;4542.477615074309;4545.818167273338;4546.88632784183;4552.476465206478;4556.066006468666;4609.446866375989;4610.492845786961;4612.654050946193;4613.76931153441;4615.076984603093;5331.680099194061;5346.812861549827;5354.732263386815;5375.408705042442;5408.3509978802795;6513.609183449008;6632.966835165793;6664.7000884959325;6669.833254168685;6671.3995740382625;1678.211240716861;1695.6693444778396;1696.4825728152784;1701.038913014143;1702.6169111949712;1094.4473041114186;1106.5020740666732;1123.2361993844102;1138.59579849154;1152.9162587168034;6333.96833015832;6337.809865703944;6338.366163383625;6350.333215012357;6352.396522330371;6790.287019862942;6832.760853370109;6865.725370985105;6867.965660171667;6876.931230687729;6191.876162476725;6267.341929097471;6310.968445157745;6376.692777980503;6395.008773640093;3689.040849379127;3696.5748938871834;3713.9442908356395;3718.572364178154;3725.590185079693;7162.176349719744;7199.568025918462;7226.5664060155505;7242.45681573884;7255.709771609182;6952.930470695228;7023.122109736283;7049.7885063448175;7104.538205016657;7117.857642847218;7263.673134708951;7271.127464704269;7312.1956584775635;7339.853202935911;7342.045534080428;6918.342757438036;6933;6933.930660693329;6947.305269473012;6962;6657.7669781557415;6827.21487028998;6837.829054273484;6848.2124555674745;6859.348361905611;7197.568145911262;7215.530990485601;7221.783346499614;7224.819379515554;7242.348188663045;4581.908361832811;4620.5841474266135;4628.236341003697;4629.398178236807;4637.188492013952;6829.1611769872325;6835.863282734417;6936.0636314096955;6940.41006514452;6951.16586009682;6699.162604674416;6705.9605761107105;6707.295733947865;6712.966435167793;6713.6307503085845;6592.143021407186;6658.966705166443;6671.199456065303;6698.7320507179165;6762.49281303914;6515.381038801306;6532.216134063943;6553.639549824806;6563.1796025496815;6587.242467116343;6684.398404143456;6696.698648560924;6711;6715.93284067153;6717.05961165447;6455.3221911700475;6574.605523668595;6583.473322134314;6585.0574080645365;6595.175603049619 09:18:54 INFO - PROCESS | 25863 | |5;yui.html;696.2132789947359;765.9157492675805;814.4583851738598;833.4166083741379;858.4806192253691;12796.296203708793;12957.35213239339;13058;13067.019973501978;13080.60758177255;10862.34825910446;11972.580959666413;12004.339761313124;12046.759064818698;12310.384480775947;798.876174193001;804.947678400905;807.3541167066353;807.6527093349857;808.9595520223995;799.5482552357928;807.2694211738386;807.6042739057879;808.337163525909;809.4738420026971;829.0548774397192;830.904445988713;833.6123702478346;838.4256784102879;839.5844057191699;823.5882058970515;829.0341751859077;832.5670651261311;832.7127141136298;834.7996480844583;595.9046552551571;606.3572613030202;607.2227548737623;610.2372034956304;610.4140025575452;12476.937615311865;12619.179753316097;12640.178388404816;12757.74484510314;12771.233725976472;11878.524859005629;12063.698407539794;12180.81728774069;12334.198277111958;12531.373431328397;9586.424814511152;9654.22766178704;9787.706368808947;10127.746806329827;10134.13859821916;3530.6998905093096;3571.160777217352;3596.352656521825;3598.316319899237;3619.0771353305004;44457.3331400026;44461.333080003824;44467.555324446665;44599.331010034875;45086.77456612696;9019.413738107001;9028.09719028092;9221.81556368869;9234.122758337948;9362.531873406302;15682.921585392;15880.126593037263;16392.918035409984;16470.09414482215;16611.169441527876;7042.295770422917;7074.858502830018;7105.111861017373;7130.322619351154;7131.0373099631925;4006.1386801837743;4033.1127152026506;4146.37804329353;4198.895027624334;4206.348016057516;3031.621047369079;3052;3085.568020477135;3085.6760040195904;3097.303106800997;566.2412367427667;577.9971100144472;578.2684903596953;578.2684903596953;578.8205656246577;511.0902593383783;522.5427750718121;523.6779380680854;529.8781280305551;530.2867643020131;7815.25755053269;8016.959915200387;8081.959590202011;8089.595520223966;8419.663213471515;615.4399496458202;621.5269810548938;663.6947004377944;682.382443888282;711.434409644334;3921.9019524511546;3955.980220098881;3985.20295940813;4004.150826673027;4114.835406583763;58310.125348119815;58532;58657;58906;59134.704326478095;49197.50802492001;50309;50883.745581271854;51428.11432913867;51631;42643.78678106589;43397;44904.77547612241;45401.31898021532;45787.54212457899;7986.680532778624;7996.5601891894175;8328.958355208186;8409.915900841159;8602.741917742478;32972.67027329696;33917;35109.297814043064;36913.07717307089;37442.812785935894;40472.1905561893;41198.58801411947;42308.57691423046;46854.29718554156;47685;10729.517171727135;10755.408452535186;10889.401082940514;11043.558257669603;11166.162537809534;11855.407229638311;11877.346745929057;12030.939845300718;12050.879491204976;12354.492632914807;11113.166512511756;11188.66434006981;11211.271267367594;11236.438178090899;11816.025707679102;10704.225352112613;10755;10775.892241077489;10866.239363244496;10872.67381978542;9867.605295788087;9941.353812002197;10184.879663237187;10333.966603339606;10374.844377334497;9155.542222888962;9237.630494780133;9545.236381089635;9565;9795.314327996972;8539.573021349031;8662.523561204194;8749.650013999624;8847.601857916537;9074.90925090767 09:18:54 INFO - PROCESS | 25863 | __end_tp_report 09:18:54 INFO - PROCESS | 25863 | __start_cc_report 09:18:54 INFO - PROCESS | 25863 | _x_x_mozilla_cycle_collect,301 09:18:54 INFO - PROCESS | 25863 | __end_cc_report 09:18:54 INFO - PROCESS | 25863 | __startTimestamp1453828734310__endTimestamp 09:18:54 INFO - PROCESS | 25863 | 09:18:54 INFO - PROCESS | 25863 | ------- Summary: start ------- 09:18:54 INFO - PROCESS | 25863 | Number of tests: 6 09:18:54 INFO - PROCESS | 25863 | 09:18:54 INFO - PROCESS | 25863 | [#0] dojo.html Cycles:165 Average:5376.12 Median:5571.58 stddev:590.08 (10.6%) stddev-sans-first:567.89 09:18:54 INFO - PROCESS | 25863 | Values: 3252.7 3283.3 3312.8 3319.2 3322.4 5234.9 5312.0 5325.2 5362.4 5374.1 5258.4 5324.9 5325.0 5378.9 5394.3 4965.8 4980.0 5022.8 5111.4 5114.0 4965.4 5026.5 5028.4 5037.2 5078.4 4655.6 4845.1 4967.5 4976.2 4978.5 4936.1 4983.3 4985.0 5005.3 5014.5 4879.1 4942.4 4949.3 4954.1 5032.8 5154.0 5178.4 5182.0 5218.4 5264.4 5852.4 5853.3 5861.2 5871.3 5873.9 5778.3 5883.2 5884.4 5903.8 5907.2 5420.0 5433.3 5438.3 5441.3 5486.8 5881.7 5882.5 5888.2 5893.4 5894.3 5649.3 5656.5 5666.9 5670.4 5671.7 5808.9 5849.8 5852.5 5861.3 5908.1 5749.6 5790.5 5803.1 5807.4 5809.9 5613.2 5676.3 5775.7 5779.0 5792.6 4370.1 4382.6 4388.9 4400.8 4418.1 3961.9 3992.7 3995.3 4023.8 4026.8 5355.0 5383.3 5405.8 5433.8 5539.3 5717.8 5743.0 5769.7 5776.7 5787.5 5338.2 5389.7 5405.6 5421.1 5467.4 4714.0 4780.1 4844.4 4946.8 4969.6 5924.3 5938.2 5944.6 5956.3 5958.9 5684.9 5718.8 5743.7 5748.9 5755.5 5893.8 5923.9 5934.8 6001.9 6026.9 5737.0 5752.1 5770.9 5794.8 5814.4 5852.8 5877.9 5886.7 5887.1 5890.9 5527.1 5559.4 5559.9 5669.0 5723.8 5653.0 5677.9 5720.8 5725.5 5725.6 5494.4 5589.4 5605.4 5621.2 5623.4 5571.1 5671.5 5680.0 5750.4 5792.8 5525.5 5539.9 5571.6 5578.5 5599.8 09:18:54 INFO - PROCESS | 25863 | 09:18:54 INFO - PROCESS | 25863 | [#1] ext.html Cycles:180 Average:43776.46 Median:35310.97 stddev:73427.66 (207.9%) stddev-sans-first:73561.83 09:18:54 INFO - PROCESS | 25863 | Values: 526.0 533.8 548.1 554.2 560.0 34608.0 35238.3 35383.6 35400.3 35417.1 38642.4 38892.0 39036.4 39043.8 39061.4 8377.5 8527.6 8544.2 8569.6 8576.8 8266.2 8392.3 8427.8 8552.8 8618.3 8591.0 8624.0 8639.3 8685.9 8694.3 8541.2 8546.8 8588.4 8594.1 8660.0 8467.1 8558.1 8589.0 8625.3 8651.0 38313.6 38512.6 38643.2 38708.6 38731.2 3305.2 3322.5 3563.5 3664.9 3901.1 29115.3 29413.4 29435.3 30286.0 30550.7 3911.3 3919.8 3939.6 4022.3 4106.3 253533.0 254900.0 254994.0 256233.0 256458.0 54993.7 55094.7 55370.2 55410.2 56293.4 59705.7 60752.7 60774.0 60870.1 61468.0 11918.3 11956.1 11976.2 12066.1 12118.5 9071.7 9075.2 9079.2 9084.7 9124.0 18676.1 18705.2 18845.3 19509.9 19640.0 7583.7 7756.7 7816.4 7855.1 7860.2 973.3 1005.4 1040.7 1068.3 1070.3 28260.3 28323.9 28371.0 28691.3 28829.3 991.1 993.6 1011.4 1011.6 1058.4 14734.4 15404.0 15606.0 15938.6 16395.1 327969.0 330050.0 330681.0 331823.0 333261.0 43917.3 44200.1 44654.8 44670.8 44801.1 1310.1 1315.3 1323.6 1343.4 1343.9 24914.3 25941.6 27442.9 27487.2 27797.7 42267.6 42332.4 42366.2 42578.0 42802.6 246036.0 248792.0 249063.0 249121.0 249381.0 29798.7 30538.2 31114.7 31131.2 31384.2 36081.5 36396.6 36962.0 37147.4 37393.8 33567.1 33994.8 34052.3 34671.5 35114.3 33654.3 34448.1 34588.7 34727.5 34738.5 34223.1 34559.5 34698.8 35070.0 35178.6 26276.3 27593.7 29246.9 29470.0 29728.6 22738.7 22801.7 23246.8 24109.0 24260.0 09:18:54 INFO - PROCESS | 25863 | 09:18:54 INFO - PROCESS | 25863 | [#2] jquery.html Cycles:180 Average:27124.30 Median:448.26 stddev:88526.41 (19748.8%) stddev-sans-first:88751.94 09:18:54 INFO - PROCESS | 25863 | Values: 362.9 367.9 369.6 371.6 376.4 15351.7 16340.6 16788.9 16821.9 17924.2 11154.1 11295.8 16630.3 16731.7 16746.3 4806.1 5123.9 5127.8 5133.4 5148.3 4739.9 5020.3 5068.3 5069.6 5070.5 3736.2 3916.6 5352.4 6106.9 6123.1 5417.8 5475.3 5479.9 5483.5 5554.4 5307.4 5307.5 5351.2 5359.9 5363.2 12514.4 13851.9 18270.0 18663.4 18776.7 2213.5 2220.9 2252.5 2253.3 2291.9 8845.5 8920.4 8925.3 9179.4 9766.3 1833.6 1861.3 1864.9 1874.7 1903.4 55182.0 56076.0 56772.4 57617.4 58413.1 10223.4 10316.0 10316.1 10360.7 10383.9 13294.7 13322.5 13448.5 13474.3 13531.2 6638.0 6737.8 6901.3 6950.1 7014.6 6354.5 6358.4 6440.0 6453.9 6471.4 4496.5 4499.0 4528.1 4559.7 4573.0 1877.9 1916.3 1933.0 1941.3 1968.1 404.5 408.0 415.6 448.2 458.0 10092.0 10821.5 10855.9 11009.6 11244.4 443.9 444.1 445.0 448.3 459.0 5923.6 6096.7 9151.2 9703.0 9879.3 530476.0 534198.0 538292.0 549922.0 553748.0 71322.0 71340.0 71357.0 71557.6 73193.0 1064.6 1094.0 1098.9 1102.6 1119.1 14996.9 15143.5 15194.1 15333.8 15458.8 32467.8 33109.0 33792.8 34355.5 34575.8 43988.0 44390.8 44822.6 45246.1 47593.5 6908.7 6956.2 6987.2 7286.5 7312.9 10085.2 10695.8 10857.8 10944.5 11164.2 9133.5 9349.2 9382.8 9539.7 9762.9 8564.7 9904.0 10043.8 10080.8 10299.4 3085.3 4137.0 6765.4 10399.4 10439.5 7349.8 7625.3 7632.9 7661.9 7761.5 7146.4 9031.4 10051.7 10185.2 10429.7 09:18:54 INFO - PROCESS | 25863 | 09:18:54 INFO - PROCESS | 25863 | [#3] mootools.html Cycles:180 Average:5495.41 Median:6639.08 stddev:2888.28 (43.5%) stddev-sans-first:2880.66 09:18:54 INFO - PROCESS | 25863 | Values: 1485.5 1497.8 1665.1 1729.8 1796.8 7709.2 7822.7 7858.6 7909.6 7919.4 7906.7 7927.0 7952.8 7974.8 7995.8 2239.7 2265.2 2270.9 2280.0 2294.4 2205.2 2215.6 2250.7 2250.9 2254.3 1923.8 1974.6 2262.9 2299.5 2308.5 2182.8 2215.2 2236.5 2239.5 2241.3 2259.1 2266.6 2266.9 2282.4 2300.5 7405.6 7436.9 7477.3 7480.9 7495.9 4590.2 4690.1 4700.4 4706.9 4711.0 3005.8 3011.7 3133.0 3166.5 3168.8 934.5 947.1 954.0 1831.6 1857.2 10576.7 10645.4 10674.8 10714.4 10738.3 4041.9 4061.2 4090.3 4092.0 4263.4 8783.2 8826.2 8826.5 8827.3 8874.7 4627.8 4650.4 4683.1 4686.4 4689.6 4266.4 4286.8 4304.1 4318.5 4334.4 3490.1 3531.9 3557.8 3569.6 3578.9 1074.3 1078.4 1104.0 1117.0 1131.5 977.1 1012.9 1046.5 1302.9 1346.0 7212.9 7236.0 7331.6 7344.4 7362.4 619.4 634.9 637.6 639.3 772.8 5372.8 5505.0 5713.7 5734.8 5767.1 9525.9 9526.9 9682.1 9842.8 9898.0 9685.9 9730.7 9766.2 9788.8 9808.5 7169.7 7580.0 7614.5 7626.5 7638.2 7330.5 7386.3 7420.1 7421.8 7435.4 8367.5 8433.0 8568.1 8599.2 8611.5 8505.2 8687.4 8687.5 8724.1 8726.5 6873.4 7017.6 7090.8 7097.5 7133.9 7546.9 7552.7 7598.8 7607.8 7638.2 6973.7 7168.9 7176.2 7266.3 7313.5 6834.7 6897.5 7022.2 7041.9 7060.6 7137.0 7255.1 7255.4 7303.9 7304.0 6345.2 6514.0 6516.5 6522.3 6526.7 6624.0 6654.2 6722.1 6724.8 6735.4 09:18:54 INFO - PROCESS | 25863 | 09:18:54 INFO - PROCESS | 25863 | [#4] prototype.html Cycles:180 Average:5546.38 Median:6289.16 stddev:1702.04 (27.1%) stddev-sans-first:1660.99 09:18:54 INFO - PROCESS | 25863 | Values: 319.8 326.3 328.4 336.1 344.8 6131.8 6215.3 6219.5 6233.2 6324.4 6134.8 6205.8 6235.0 6257.5 6265.8 4710.3 4743.4 4752.6 4757.3 4764.3 4758.5 4759.2 4764.1 4769.2 4770.3 4615.1 4616.4 4639.6 4707.8 4716.9 4645.4 4649.1 4655.3 4655.8 4667.7 4097.0 4111.5 4129.9 4131.0 4155.1 5886.9 5945.2 5948.3 5952.2 5961.9 5466.0 5492.4 5535.3 5568.1 5576.7 6580.7 6598.4 6610.4 6615.4 6617.0 4597.4 4618.9 4622.9 4623.3 4629.1 6643.8 6818.0 6826.8 6909.6 6913.0 4542.5 4545.8 4546.9 4552.5 4556.1 4609.4 4610.5 4612.7 4613.8 4615.1 5331.7 5346.8 5354.7 5375.4 5408.4 6513.6 6633.0 6664.7 6669.8 6671.4 1678.2 1695.7 1696.5 1701.0 1702.6 1094.4 1106.5 1123.2 1138.6 1152.9 6334.0 6337.8 6338.4 6350.3 6352.4 6790.3 6832.8 6865.7 6868.0 6876.9 6191.9 6267.3 6311.0 6376.7 6395.0 3689.0 3696.6 3713.9 3718.6 3725.6 7162.2 7199.6 7226.6 7242.5 7255.7 6952.9 7023.1 7049.8 7104.5 7117.9 7263.7 7271.1 7312.2 7339.9 7342.0 6918.3 6933.0 6933.9 6947.3 6962.0 6657.8 6827.2 6837.8 6848.2 6859.3 7197.6 7215.5 7221.8 7224.8 7242.3 4581.9 4620.6 4628.2 4629.4 4637.2 6829.2 6835.9 6936.1 6940.4 6951.2 6699.2 6706.0 6707.3 6713.0 6713.6 6592.1 6659.0 6671.2 6698.7 6762.5 6515.4 6532.2 6553.6 6563.2 6587.2 6684.4 6696.7 6711.0 6715.9 6717.1 6455.3 6574.6 6583.5 6585.1 6595.2 09:18:54 INFO - PROCESS | 25863 | 09:18:54 INFO - PROCESS | 25863 | [#5] yui.html Cycles:180 Average:13344.93 Median:49753.25 stddev:15697.82 (31.6%) stddev-sans-first:15713.12 09:18:54 INFO - PROCESS | 25863 | Values: 696.2 765.9 814.5 833.4 858.5 12796.3 12957.4 13058.0 13067.0 13080.6 10862.3 11972.6 12004.3 12046.8 12310.4 798.9 804.9 807.4 807.7 809.0 799.5 807.3 807.6 808.3 809.5 829.1 830.9 833.6 838.4 839.6 823.6 829.0 832.6 832.7 834.8 595.9 606.4 607.2 610.2 610.4 12476.9 12619.2 12640.2 12757.7 12771.2 11878.5 12063.7 12180.8 12334.2 12531.4 9586.4 9654.2 9787.7 10127.7 10134.1 3530.7 3571.2 3596.4 3598.3 3619.1 44457.3 44461.3 44467.6 44599.3 45086.8 9019.4 9028.1 9221.8 9234.1 9362.5 15682.9 15880.1 16392.9 16470.1 16611.2 7042.3 7074.9 7105.1 7130.3 7131.0 4006.1 4033.1 4146.4 4198.9 4206.3 3031.6 3052.0 3085.6 3085.7 3097.3 566.2 578.0 578.3 578.3 578.8 511.1 522.5 523.7 529.9 530.3 7815.3 8017.0 8082.0 8089.6 8419.7 615.4 621.5 663.7 682.4 711.4 3921.9 3956.0 3985.2 4004.2 4114.8 58310.1 58532.0 58657.0 58906.0 59134.7 49197.5 50309.0 50883.7 51428.1 51631.0 42643.8 43397.0 44904.8 45401.3 45787.5 7986.7 7996.6 8329.0 8409.9 8602.7 32972.7 33917.0 35109.3 36913.1 37442.8 40472.2 41198.6 42308.6 46854.3 47685.0 10729.5 10755.4 10889.4 11043.6 11166.2 11855.4 11877.3 12030.9 12050.9 12354.5 11113.2 11188.7 11211.3 11236.4 11816.0 10704.2 10755.0 10775.9 10866.2 10872.7 9867.6 9941.4 10184.9 10334.0 10374.8 9155.5 9237.6 9545.2 9565.0 9795.3 8539.6 8662.5 8749.7 8847.6 9074.9 09:18:54 INFO - PROCESS | 25863 | -------- Summary: end -------- 09:18:54 INFO - PROCESS | 25863 | 09:18:54 INFO - TEST-INFO | 25863: exit 0 09:18:55 INFO - TEST-OK | dromaeo_css | took 1110820ms 09:18:55 INFO - TEST-START | kraken 09:18:55 INFO - operating with platform_type : linux_ 09:18:55 INFO - Initialising browser for kraken test... 09:18:55 INFO - TEST-INFO | started process 26106 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOakxM5/profile http://localhost:43574/getInfo.html) 09:18:58 INFO - PROCESS | 26106 | 09:18:58 INFO - PROCESS | 26106 | (process:26177): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:18:59 INFO - PROCESS | 26106 | __metrics Screen width/height:1600/1200 09:18:59 INFO - PROCESS | 26106 | colorDepth:24 09:18:59 INFO - PROCESS | 26106 | Browser inner width/height: 1024/697 09:18:59 INFO - PROCESS | 26106 | __metrics 09:18:59 INFO - PROCESS | 26106 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:19:00 INFO - TEST-INFO | 26106: exit 0 09:19:00 INFO - Browser initialized. 09:19:00 INFO - Running cycle 1/1 for kraken test... 09:19:00 INFO - TEST-INFO | started process 26226 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOakxM5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:01 INFO - PROCESS | 26226 | 09:19:01 INFO - PROCESS | 26226 | (process:26284): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:19:12 INFO - PROCESS | 26226 | RSS: Main: 150695936 09:19:12 INFO - PROCESS | 26226 | 09:19:14 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43574/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:15 INFO - PROCESS | 26226 | RSS: Main: 154521600 09:19:15 INFO - PROCESS | 26226 | 09:19:18 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43574/tests/kraken/driver.html?testName=audio-dft) 09:19:18 INFO - PROCESS | 26226 | RSS: Main: 159428608 09:19:18 INFO - PROCESS | 26226 | 09:19:21 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43574/tests/kraken/driver.html?testName=audio-fft) 09:19:22 INFO - PROCESS | 26226 | RSS: Main: 151322624 09:19:22 INFO - PROCESS | 26226 | 09:19:24 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43574/tests/kraken/driver.html?testName=audio-oscillator) 09:19:25 INFO - PROCESS | 26226 | RSS: Main: 151830528 09:19:25 INFO - PROCESS | 26226 | 09:19:27 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43574/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:27 INFO - PROCESS | 26226 | RSS: Main: 152018944 09:19:27 INFO - PROCESS | 26226 | 09:19:30 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43574/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:31 INFO - PROCESS | 26226 | RSS: Main: 151994368 09:19:31 INFO - PROCESS | 26226 | 09:19:34 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43574/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:35 INFO - PROCESS | 26226 | RSS: Main: 152809472 09:19:35 INFO - PROCESS | 26226 | 09:19:38 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43574/tests/kraken/driver.html?testName=json-parse-financial) 09:19:38 INFO - PROCESS | 26226 | RSS: Main: 155422720 09:19:38 INFO - PROCESS | 26226 | 09:19:40 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43574/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:40 INFO - PROCESS | 26226 | RSS: Main: 154677248 09:19:40 INFO - PROCESS | 26226 | 09:19:42 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43574/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:43 INFO - PROCESS | 26226 | RSS: Main: 155758592 09:19:43 INFO - PROCESS | 26226 | 09:19:45 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43574/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:19:45 INFO - PROCESS | 26226 | RSS: Main: 155500544 09:19:45 INFO - PROCESS | 26226 | 09:19:48 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:19:49 INFO - PROCESS | 26226 | RSS: Main: 155086848 09:19:49 INFO - PROCESS | 26226 | 09:19:51 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:19:52 INFO - PROCESS | 26226 | RSS: Main: 154320896 09:19:52 INFO - PROCESS | 26226 | 09:19:53 INFO - PROCESS | 26226 | Cycle 1(1): loaded http://localhost:43574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43574/tests/kraken/driver.html?testName=ai-astar) 09:19:54 INFO - PROCESS | 26226 | RSS: Main: 156921856 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | __start_tp_report 09:19:54 INFO - PROCESS | 26226 | _x_x_mozilla_page_load 09:19:54 INFO - PROCESS | 26226 | _x_x_mozilla_page_load_details 09:19:54 INFO - PROCESS | 26226 | |i|pagename|runs| 09:19:54 INFO - PROCESS | 26226 | |0;ai-astar;112;108;111;112;112;124;111;113;112;114 09:19:54 INFO - PROCESS | 26226 | |1;audio-beat-detection;162;128;153;171;126;152;152;134;171;130 09:19:54 INFO - PROCESS | 26226 | |2;audio-dft;164;162;164;160;161;161;165;167;165;163 09:19:54 INFO - PROCESS | 26226 | |3;audio-fft;76;73;73;73;73;142;73;74;74;73 09:19:54 INFO - PROCESS | 26226 | |4;audio-oscillator;98;96;142;96;96;97;139;96;98;137 09:19:54 INFO - PROCESS | 26226 | |5;imaging-gaussian-blur;110;111;109;109;109;111;110;110;109;109 09:19:54 INFO - PROCESS | 26226 | |6;imaging-darkroom;146;146;147;146;147;149;147;146;146;146 09:19:54 INFO - PROCESS | 26226 | |7;imaging-desaturate;97;97;97;96;97;97;96;96;97;96 09:19:54 INFO - PROCESS | 26226 | |8;json-parse-financial;63;60;59;59;60;60;64;58;68;57 09:19:54 INFO - PROCESS | 26226 | |9;json-stringify-tinderbox;68;68;72;68;70;68;67;68;71;67 09:19:54 INFO - PROCESS | 26226 | |10;stanford-crypto-aes;81;89;86;83;83;82;82;83;84;83 09:19:54 INFO - PROCESS | 26226 | |11;stanford-crypto-ccm;118;131;116;112;113;119;120;120;124;114 09:19:54 INFO - PROCESS | 26226 | |12;stanford-crypto-pbkdf2;127;140;142;140;141;139;145;143;139;134 09:19:54 INFO - PROCESS | 26226 | |13;stanford-crypto-sha256-iterative;67;71;68;70;69;69;69;68;66;65 09:19:54 INFO - PROCESS | 26226 | __end_tp_report 09:19:54 INFO - PROCESS | 26226 | __start_cc_report 09:19:54 INFO - PROCESS | 26226 | _x_x_mozilla_cycle_collect,733 09:19:54 INFO - PROCESS | 26226 | __end_cc_report 09:19:54 INFO - PROCESS | 26226 | __startTimestamp1453828794062__endTimestamp 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | ------- Summary: start ------- 09:19:54 INFO - PROCESS | 26226 | Number of tests: 14 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.00 stddev:4.20 (3.8%) stddev-sans-first:4.44 09:19:54 INFO - PROCESS | 26226 | Values: 112.0 108.0 111.0 112.0 112.0 124.0 111.0 113.0 112.0 114.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:152.50 stddev:17.37 (11.4%) stddev-sans-first:17.66 09:19:54 INFO - PROCESS | 26226 | Values: 162.0 128.0 153.0 171.0 126.0 152.0 152.0 134.0 171.0 130.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#2] audio-dft Cycles:10 Average:163.20 Median:164.00 stddev:2.20 (1.3%) stddev-sans-first:2.32 09:19:54 INFO - PROCESS | 26226 | Values: 164.0 162.0 164.0 160.0 161.0 161.0 165.0 167.0 165.0 163.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#3] audio-fft Cycles:10 Average:80.40 Median:73.00 stddev:21.67 (29.7%) stddev-sans-first:22.92 09:19:54 INFO - PROCESS | 26226 | Values: 76.0 73.0 73.0 73.0 73.0 142.0 73.0 74.0 74.0 73.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:20.64 (21.5%) stddev-sans-first:21.46 09:19:54 INFO - PROCESS | 26226 | Values: 98.0 96.0 142.0 96.0 96.0 97.0 139.0 96.0 98.0 137.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 09:19:54 INFO - PROCESS | 26226 | Values: 110.0 111.0 109.0 109.0 109.0 111.0 110.0 110.0 109.0 109.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.00 09:19:54 INFO - PROCESS | 26226 | Values: 146.0 146.0 147.0 146.0 147.0 149.0 147.0 146.0 146.0 146.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:19:54 INFO - PROCESS | 26226 | Values: 97.0 97.0 97.0 96.0 97.0 97.0 96.0 96.0 97.0 96.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:60.00 stddev:3.29 (5.5%) stddev-sans-first:3.40 09:19:54 INFO - PROCESS | 26226 | Values: 63.0 60.0 59.0 59.0 60.0 60.0 64.0 58.0 68.0 57.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.00 stddev:1.70 (2.5%) stddev-sans-first:1.79 09:19:54 INFO - PROCESS | 26226 | Values: 68.0 68.0 72.0 68.0 70.0 68.0 67.0 68.0 71.0 67.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:2.32 (2.8%) stddev-sans-first:2.26 09:19:54 INFO - PROCESS | 26226 | Values: 81.0 89.0 86.0 83.0 83.0 82.0 82.0 83.0 84.0 83.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.50 stddev:5.68 (4.8%) stddev-sans-first:6.02 09:19:54 INFO - PROCESS | 26226 | Values: 118.0 131.0 116.0 112.0 113.0 119.0 120.0 120.0 124.0 114.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:140.50 stddev:5.12 (3.6%) stddev-sans-first:3.08 09:19:54 INFO - PROCESS | 26226 | Values: 127.0 140.0 142.0 140.0 141.0 139.0 145.0 143.0 139.0 134.0 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - PROCESS | 26226 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.81 (2.6%) stddev-sans-first:1.87 09:19:54 INFO - PROCESS | 26226 | Values: 67.0 71.0 68.0 70.0 69.0 69.0 69.0 68.0 66.0 65.0 09:19:54 INFO - PROCESS | 26226 | -------- Summary: end -------- 09:19:54 INFO - PROCESS | 26226 | 09:19:54 INFO - TEST-INFO | 26226: exit 0 09:19:55 INFO - TEST-OK | kraken | took 60009ms 09:19:55 INFO - TEST-START | v8_7 09:19:55 INFO - operating with platform_type : linux_ 09:19:55 INFO - Initialising browser for v8_7 test... 09:19:55 INFO - TEST-INFO | started process 26512 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprojkk4/profile http://localhost:43574/getInfo.html) 09:19:58 INFO - PROCESS | 26512 | 09:19:58 INFO - PROCESS | 26512 | (process:26584): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:19:59 INFO - PROCESS | 26512 | __metrics Screen width/height:1600/1200 09:19:59 INFO - PROCESS | 26512 | colorDepth:24 09:19:59 INFO - PROCESS | 26512 | Browser inner width/height: 1024/697 09:19:59 INFO - PROCESS | 26512 | __metrics 09:19:59 INFO - PROCESS | 26512 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:20:00 INFO - TEST-INFO | 26512: exit 0 09:20:00 INFO - Browser initialized. 09:20:00 INFO - Running cycle 1/1 for v8_7 test... 09:20:00 INFO - TEST-INFO | started process 26633 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprojkk4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:02 INFO - PROCESS | 26633 | 09:20:02 INFO - PROCESS | 26633 | (process:26692): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:20:12 INFO - PROCESS | 26633 | RSS: Main: 150454272 09:20:12 INFO - PROCESS | 26633 | 09:20:34 INFO - PROCESS | 26633 | Cycle 1(1): loaded http://localhost:43574/tests/v8_7/run.html (next: http://localhost:43574/tests/v8_7/run.html) 09:20:35 INFO - PROCESS | 26633 | RSS: Main: 151871488 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | __start_tp_report 09:20:35 INFO - PROCESS | 26633 | _x_x_mozilla_page_load 09:20:35 INFO - PROCESS | 26633 | _x_x_mozilla_page_load_details 09:20:35 INFO - PROCESS | 26633 | |i|pagename|runs| 09:20:35 INFO - PROCESS | 26633 | |0;Richards;166.30633627141194 09:20:35 INFO - PROCESS | 26633 | |1;DeltaBlue;197.7456990310461 09:20:35 INFO - PROCESS | 26633 | |2;Encrypt;284.3332385555872 09:20:35 INFO - PROCESS | 26633 | |3;Decrypt;5229.166666666667 09:20:35 INFO - PROCESS | 26633 | |4;RayTrace;1074.1138560687432 09:20:35 INFO - PROCESS | 26633 | |5;Earley;748.502994011976 09:20:35 INFO - PROCESS | 26633 | |6;Boyer;12256.09756097561 09:20:35 INFO - PROCESS | 26633 | |7;RegExp;42750 09:20:35 INFO - PROCESS | 26633 | |8;Splay;578.0346820809249 09:20:35 INFO - PROCESS | 26633 | |9;NavierStokes;4830.917874396136 09:20:35 INFO - PROCESS | 26633 | __end_tp_report 09:20:35 INFO - PROCESS | 26633 | __startTimestamp1453828835180__endTimestamp 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | ------- Summary: start ------- 09:20:35 INFO - PROCESS | 26633 | Number of tests: 10 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | [#0] Richards Cycles:1 Average:166.31 Median:166.31 stddev:0.00 (0.0%) 09:20:35 INFO - PROCESS | 26633 | Values: 166.3 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | [#1] DeltaBlue Cycles:1 Average:197.75 Median:197.75 stddev:0.00 (0.0%) 09:20:35 INFO - PROCESS | 26633 | Values: 197.7 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | [#2] Encrypt Cycles:1 Average:284.33 Median:284.33 stddev:0.00 (0.0%) 09:20:35 INFO - PROCESS | 26633 | Values: 284.3 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 09:20:35 INFO - PROCESS | 26633 | Values: 5229.2 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 09:20:35 INFO - PROCESS | 26633 | Values: 1074.1 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | [#5] Earley Cycles:1 Average:748.50 Median:748.50 stddev:0.00 (0.0%) 09:20:35 INFO - PROCESS | 26633 | Values: 748.5 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 09:20:35 INFO - PROCESS | 26633 | Values: 12256.1 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | [#7] RegExp Cycles:1 Average:42750.00 Median:42750.00 stddev:0.00 (0.0%) 09:20:35 INFO - PROCESS | 26633 | Values: 42750.0 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | [#8] Splay Cycles:1 Average:578.03 Median:578.03 stddev:0.00 (0.0%) 09:20:35 INFO - PROCESS | 26633 | Values: 578.0 09:20:35 INFO - PROCESS | 26633 | 09:20:35 INFO - PROCESS | 26633 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 09:20:35 INFO - PROCESS | 26633 | Values: 4830.9 09:20:35 INFO - PROCESS | 26633 | -------- Summary: end -------- 09:20:35 INFO - PROCESS | 26633 | 09:20:36 INFO - TEST-INFO | 26633: exit 0 09:20:36 INFO - TEST-OK | v8_7 | took 41030ms 09:20:36 INFO - SUITE-END | took 1211s 09:20:36 INFO - Completed test suite (00:20:12) 09:20:36 INFO - Working with test: dromaeo_css 09:20:36 INFO - Generating results file: dromaeo_css 09:20:36 INFO - Working with test: kraken 09:20:36 INFO - Generating results file: kraken 09:20:36 INFO - javascript benchmark 09:20:36 INFO - Working with test: v8_7 09:20:36 INFO - Generating results file: v8_7 09:20:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:20:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 09:20:36 INFO - process_Request line: dromaeo_css 6759.45 graph.html#tests=[[72,1,43]] 09:20:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:20:36 INFO - process_Request line: kraken 1505.80 graph.html#tests=[[232,1,43]] 09:20:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:20:36 INFO - process_Request line: v8_7 20145.07 graph.html#tests=[[230,1,43]] 09:20:36 INFO - RETURN: dromaeo_css: 6759.45 09:20:36 INFO - RETURN: kraken: 1505.80 09:20:36 INFO - RETURN: v8_7: 20145.07 09:20:36 INFO - javascript benchmark 09:20:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3252.6909943555365, 3283.3269179818126, 3312.801231926086, 3319.1702074481386, 3322.4019676458242, 5234.8745019820735, 5312.043832110228, 5325.201219817024, 5362.410134885165, 5374.140137577989, 5258.368995720519, 5324.893502129965, 5325.0, 5378.946210537893, 5394.271773310602, 4965.801367945287, 4979.975100124494, 5022.773975171108, 5111.386633603973, 5114.028334616411, 4965.3545039144865, 5026.497350264981, 5028.371453568304, 5037.168867136918, 5078.415982162043, 4655.604273636745, 4845.079434907357, 4967.453580106186, 4976.2286845539, 4978.452370239271, 4936.136176169192, 4983.327250821165, 4985.0, 5005.299258103868, 5014.498550144993, 4879.072976134523, 4942.431620363633, 4949.307097006422, 4954.133026720346, 5032.823851165228, 5154.0, 5178.378594568639, 5182.0, 5218.425973142951, 5264.394594621629, 5852.414758524156, 5853.268341457318, 5861.20873682056, 5871.324797648283, 5873.941260587425, 5778.3354914184565, 5883.17635531026, 5884.352721200665, 5903.763849446017, 5907.202527658754, 5419.972900135474, 5433.320834895638, 5438.265834112383, 5441.347038355383, 5486.780528778884, 5881.676507792027, 5882.499987501024, 5888.205092312569, 5893.381194974466, 5894.263217097863, 5649.265595472644, 5656.547476201894, 5666.886662266814, 5670.376258611549, 5671.6597004179885, 5808.88382232353, 5849.766009359578, 5852.502537284378, 5861.296644402613, 5908.05471124618, 5749.597528173072, 5790.507806836466, 5803.100519419497, 5807.361190269067, 5809.9419005809405, 5613.242212301368, 5676.290463692038, 5775.740091695884, 5778.971105144447, 5792.565557583198, 4370.104128653618, 4382.605565499057, 4388.934165987513, 4400.779961001937, 4418.116376724668, 3961.9405708914387, 3992.680585553207, 3995.320795464778, 4023.7786921719585, 4026.7583944963394, 5354.973225133927, 5383.300170977748, 5405.78376864921, 5433.782648694087, 5539.279893613804, 5717.799877004368, 5743.0, 5769.74036168365, 5776.68228247442, 5787.536997040227, 5338.225957236179, 5389.730513474311, 5405.567554595623, 5421.1055175895535, 5467.425920278393, 4713.952860471351, 4780.139574876486, 4844.442889067732, 4946.752662366939, 4969.627277954168, 5924.289085309791, 5938.198343223696, 5944.613600115892, 5956.255468066492, 5958.85102872423, 5684.914726279192, 5718.771249150153, 5743.684097374685, 5748.9425105748405, 5755.510781583613, 5893.823185304448, 5923.851903702442, 5934.821955341346, 6001.90997135052, 6026.939730602638, 5737.0, 5752.07966725322, 5770.913436298375, 5794.783095549982, 5814.447627475383, 5852.824415267549, 5877.882442351214, 5886.676232807236, 5887.146363777314, 5890.880732660781, 5527.060399732136, 5559.388467268516, 5559.9444005561045, 5669.0, 5723.7996670116345, 5653.010723123355, 5677.8864422710485, 5720.771169153188, 5725.4560816724015, 5725.599208055396, 5494.395616482264, 5589.413111623221, 5605.383407825218, 5621.184928185472, 5623.409541998031, 5571.0807716726285, 5671.48956593892, 5679.977604031149, 5750.424957504216, 5792.797252096157, 5525.475079867406, 5539.861503462445, 5571.582131340247, 5578.470045345685, 5599.832005039855], "unit": "score", "name": "dojo.html", "value": 5338.583820573773}, {"lowerIsBetter": false, "replicates": [525.9586019681029, 533.7510226070995, 548.1394211088588, 554.1881144123857, 560.0171698668836, 34608.0, 35238.295234095334, 35383.64616353836, 35400.291994160136, 35417.11457213571, 38642.42036369457, 38892.0, 39036.414453783145, 39043.804780976054, 39061.414078788766, 8377.49735015898, 8527.616257268437, 8544.23101920827, 8569.571521423935, 8576.785580360478, 8266.214709602607, 8392.328613710919, 8427.83144337113, 8552.828943421127, 8618.310535157172, 8591.0, 8623.956880215621, 8639.308855291561, 8685.913140868573, 8694.304455643565, 8541.188587084218, 8546.78633034176, 8588.355873309527, 8594.054653988056, 8660.047394786632, 8467.068622451525, 8558.058613552505, 8589.0, 8625.309975202032, 8650.956745216234, 38313.616863831565, 38512.614873851184, 38643.227135457135, 38708.612913870784, 38731.22537549233, 3305.190228394059, 3322.4850148227065, 3563.465480177968, 3664.926701465982, 3901.1027463683513, 29115.272118197, 29413.41173176546, 29435.264118396997, 30286.0, 30550.69449305523, 3911.3350730375905, 3919.7844118573466, 3939.5863434339267, 4022.3363145081025, 4106.260873042851, 253533.0, 254900.0, 254994.0, 256233.0, 256458.0, 54993.72503137459, 55094.72452637791, 55370.16944745832, 55410.16884746651, 56293.43706562964, 59705.701471492364, 60752.69623651853, 60774.0, 60870.0869486958, 61468.0, 11918.284902905853, 11956.103292253116, 11976.161668683282, 12066.09504287182, 12118.515259389525, 9071.682491112779, 9075.228605568469, 9079.228265597367, 9084.682036128836, 9123.954380228057, 18676.06619669011, 18705.158267877978, 18845.340413085476, 19509.902450487658, 19640.0, 7583.696652133964, 7756.689732410753, 7816.374690024784, 7855.057393112863, 7860.174681658458, 973.3332667123043, 1005.3816902604846, 1040.6877936618985, 1068.257560995101, 1070.3203465799274, 28260.293492662437, 28323.858380708378, 28371.0, 28691.2827179318, 28829.27926801847, 991.0832479956011, 993.6373223773271, 1011.4285428732743, 1011.6307547745167, 1058.3702696895334, 14734.410623575151, 15404.0, 15606.0, 15938.601534961486, 16395.098269595048, 327969.0, 330050.0, 330681.0, 331823.0, 333261.0, 43917.341239881425, 44200.115997679866, 44654.776726116164, 44670.77664611656, 44801.10397792026, 1310.0502135951358, 1315.3423288355823, 1323.5764555342198, 1343.402186027228, 1343.8588948160302, 24914.25257242213, 25941.610875837254, 27442.862785685942, 27487.17538473849, 27797.722022780323, 42267.5773242276, 42332.36501452542, 42366.152676946906, 42578.0, 42802.57197427986, 246036.0, 248792.0, 249063.0, 249121.0, 249381.0, 29798.702012979593, 30538.236544086576, 31114.68885311118, 31131.221719456287, 31384.215394614403, 36081.45877811783, 36396.63603364038, 36962.0, 37147.442788358734, 37393.81303093576, 33567.12035236767, 33994.83002584971, 34052.31895362128, 34671.479927800596, 35114.297714046086, 33654.32393218519, 34448.138796530286, 34588.65411345854, 34727.47908781421, 34738.47892281567, 34223.14442138966, 34559.481607776404, 34698.826505867306, 35070.0, 35178.64821351856, 26276.343091422867, 27593.724062759116, 29246.853765731033, 29470.0, 29728.554071689374, 22738.658920115882, 22801.657975130056, 23246.767532325135, 24108.9907437281, 24260.0], "unit": "score", "name": "ext.html", "value": 17544.180758926963}, {"lowerIsBetter": false, "replicates": [362.86936702786994, 367.8657290089117, 369.56945158889897, 371.5949614919737, 376.3507948788342, 15351.69296614067, 16340.591485212846, 16788.916055419722, 16821.915890420532, 17924.193411296492, 11154.10767138629, 11295.774084518305, 16630.251638676258, 16731.749023764653, 16746.330146794113, 4806.134895718778, 5123.948760512403, 5127.769250383742, 5133.435322114565, 5148.279240906276, 4739.881502962419, 5020.272060551218, 5068.315777370063, 5069.569086627623, 5070.5183007614405, 3736.1967177056927, 3916.608339166089, 5352.357717073937, 6106.908396374058, 6123.11214873843, 5417.756200970965, 5475.288212532385, 5479.945200547983, 5483.451654834525, 5554.444555544454, 5307.363116426015, 5307.495787900143, 5351.2240725095035, 5359.946400535984, 5363.249145119687, 12514.436850341757, 13851.861481385258, 18270.0, 18663.44009679712, 18776.71834922477, 2213.524092320159, 2220.920535324241, 2252.4931890324547, 2253.3352660964892, 2291.8854057297235, 8845.469271843709, 8920.375573709844, 8925.33060020501, 9179.449233046038, 9766.316357854954, 1833.633273345323, 1861.3299212283566, 1864.8974306413143, 1874.709420039896, 1903.3909149072304, 55182.0, 56076.0, 56772.432275677544, 57617.42382576162, 58413.12380314341, 10223.386596804066, 10316.0, 10316.123129533924, 10360.740981475372, 10383.896161038445, 13294.667633309246, 13322.533711320057, 13448.462061517625, 13474.326283685776, 13531.188128712309, 6638.0, 6737.831554211184, 6901.309869013058, 6950.096487456598, 7014.649267536603, 6354.523410744213, 6358.427741503287, 6439.9696048631995, 6453.903191452132, 6471.449926756279, 4496.505384407713, 4498.977505112453, 4528.071745292207, 4559.658025648089, 4573.0, 1877.9436616901241, 1916.304070897266, 1932.9710054349196, 1941.2623203182982, 1968.0848405491515, 404.46004583880847, 408.0349972315512, 415.64047099258926, 448.18206772640065, 457.9587837094611, 10092.013360160156, 10821.513031913426, 10855.891441085647, 11009.559617615367, 11244.437778111062, 443.9289713645866, 444.0918322031453, 444.98887527812064, 448.34317724533713, 459.04518601309195, 5923.585349025527, 6096.72564734588, 9151.222146117521, 9702.951485242529, 9879.259055570861, 530476.0, 534198.0, 538292.0, 549922.0, 553748.0, 71322.0, 71340.0, 71357.0, 71557.64221178964, 73193.0, 1064.5635289531256, 1093.9890601093887, 1098.8846171152074, 1102.5920409448556, 1119.093534237254, 14996.850031499982, 15143.469978550698, 15194.088354698311, 15333.846661533242, 15458.84541154574, 32467.837660811543, 33109.0, 33792.831035845644, 34355.4846677305, 34575.82712086423, 43988.0, 44390.77804610956, 44822.551774481835, 45246.095078098915, 47593.52406476029, 6908.723651053901, 6956.200036995608, 6987.161540614956, 7286.48994570375, 7312.926870731225, 10085.193184545073, 10695.786084278427, 10857.805641379284, 10944.507497162806, 11164.218504704593, 9133.543322833964, 9349.185169637505, 9382.827146606674, 9539.713808585753, 9762.902370976199, 8564.700235491728, 9904.0, 10043.849342260019, 10080.84878726805, 10299.3820370778, 3085.336652619608, 4137.048478849942, 6765.391114799691, 10399.376037437778, 10439.478026098514, 7349.77950661481, 7625.275598818103, 7632.885506717293, 7661.88507172404, 7761.456698031084, 7146.3568278855155, 9031.36780425364, 10051.748706282402, 10185.185185185019, 10429.68710938673], "unit": "score", "name": "jquery.html", "value": 7531.709097365844}, {"lowerIsBetter": false, "replicates": [1485.4578079001164, 1497.7977972973645, 1665.142451637407, 1729.8183690712467, 1796.802351741309, 7709.190534993822, 7822.726204582841, 7858.646360913758, 7909.564973926432, 7919.366450683953, 7906.723264685737, 7927.048754149496, 7952.840943181133, 7974.840503189933, 7995.840083198347, 2239.731232252128, 2265.1958554713087, 2270.897809598572, 2279.9658005129936, 2294.357579877637, 2205.195103787114, 2215.6233440315186, 2250.707408036953, 2250.8762018089, 2254.3124347074217, 1923.7980012098737, 1974.6445639784833, 2262.8981695823727, 2299.482616411311, 2308.53829234153, 2182.7817218278124, 2215.213599172303, 2236.474428509315, 2239.473723674935, 2241.2715867343177, 2259.0850705464313, 2266.614675505152, 2266.909323627053, 2282.44080200352, 2300.4823914619246, 7405.555666660018, 7436.888446673304, 7477.252274772479, 7480.9251907480775, 7495.850082998364, 4590.150822097922, 4690.061987602493, 4700.388949436551, 4706.858794236178, 4710.952890471086, 3005.774566907469, 3011.713887180714, 3132.9843350783326, 3166.509191075387, 3168.825714585697, 934.5000424772782, 947.1144479911236, 953.9570719317647, 1831.5878927241265, 1857.229249861306, 10576.68269951895, 10645.414502202375, 10674.786504269949, 10714.357138571711, 10738.30201036938, 4041.939370909439, 4061.2283666103344, 4090.3250963591267, 4092.0383709828166, 4263.381809637585, 8783.2095111439, 8826.249768769727, 8826.51454170014, 8827.293816494664, 8874.733757987271, 4627.814887404534, 4650.372199753057, 4683.110209060268, 4686.437627484655, 4689.648276379286, 4266.4240327556, 4286.849960251377, 4304.139172165579, 4318.481782186095, 4334.393184954109, 3490.144914495914, 3531.94702079469, 3557.8221088945447, 3569.6430356964615, 3578.856845726194, 1074.3446497636435, 1078.3637653784149, 1104.0, 1117.022605220432, 1131.4625552862324, 977.1451623345974, 1012.9189664826944, 1046.5186014433293, 1302.863199364072, 1346.01068214862, 7212.891806622905, 7235.9507871358355, 7331.633418329062, 7344.412447004227, 7362.44781641379, 619.4486906653083, 634.9206349206349, 637.5537124013209, 639.3159319528061, 772.7874834420467, 5372.785088596491, 5504.972475137599, 5713.74288157034, 5734.799282025109, 5767.134929760569, 9525.904740952501, 9526.85709714355, 9682.128608425135, 9842.75393115178, 9898.0, 9685.9031409685, 9730.659426920023, 9766.169875560516, 9788.755281118029, 9808.460534670661, 7169.677364518505, 7580.0, 7614.466987310946, 7626.54240745557, 7638.236176382428, 7330.486865919548, 7386.2613738625705, 7420.109586849612, 7421.8144546386775, 7435.367993720594, 8367.497950123012, 8432.957835210786, 8568.057513673615, 8599.183077607617, 8611.48331100136, 8505.23452889243, 8687.39188256816, 8687.478751274944, 8724.083971182934, 8726.476411415335, 6873.4157596602845, 7017.578945263301, 7090.787276381717, 7097.46768992338, 7133.85732285341, 7546.924530754842, 7552.735654252075, 7598.772036838904, 7607.847843043219, 7638.236176382317, 6973.686184121828, 7168.8924666129005, 7176.210616832249, 7266.273372662691, 7313.488055836253, 6834.726610935507, 6897.544033738526, 7022.192447868356, 7041.929580704333, 7060.576365417885, 7136.964315178391, 7255.129384473897, 7255.419566434567, 7303.8539229216185, 7304.0, 6345.175127233615, 6513.967430163008, 6516.543841931019, 6522.315156908646, 6526.738930442729, 6623.966880165761, 6654.201495820533, 6722.092517510074, 6724.831879202863, 6735.393814556517], "unit": "score", "name": "mootools.html", "value": 4463.221376370682}, {"lowerIsBetter": false, "replicates": [319.80491899941035, 326.25776358783764, 328.3859183327178, 336.0674129291218, 344.7621141412427, 6131.7547298108075, 6215.347388524202, 6219.4713449356805, 6233.2208473940755, 6324.3991820776955, 6134.815955521331, 6205.751769929208, 6234.968825155868, 6257.4994000479965, 6265.780697675582, 4710.317004034413, 4743.383360163191, 4752.572268495826, 4757.333973243749, 4764.332993380929, 4758.547937945889, 4759.238521836507, 4764.118638051954, 4769.165396055694, 4770.284457331393, 4615.076984603076, 4616.3537104805355, 4639.628829693634, 4707.764611769415, 4716.858494245161, 4645.442546894361, 4649.116667833101, 4655.2784318430695, 4655.790489427984, 4667.6732628716, 4096.959030409687, 4111.48606424197, 4129.938050929209, 4131.049858532524, 4155.127423241123, 5886.852828679274, 5945.227120474354, 5948.315943666447, 5952.226210592638, 5961.940380596182, 5466.01611709892, 5492.423295553949, 5535.308086489189, 5568.136938774496, 5576.7211639417865, 6580.736770529173, 6598.406143447065, 6610.438112760421, 6615.37153970372, 6616.966915165442, 4597.448306203277, 4618.930716039262, 4622.930656040162, 4623.30650402439, 4629.120467111272, 6643.767468138641, 6817.99999999995, 6826.829329266759, 6909.550879192887, 6912.965435172842, 4542.477615074309, 4545.818167273338, 4546.88632784183, 4552.476465206478, 4556.066006468666, 4609.446866375989, 4610.492845786961, 4612.654050946193, 4613.76931153441, 4615.076984603093, 5331.680099194061, 5346.812861549827, 5354.732263386815, 5375.408705042442, 5408.3509978802795, 6513.609183449008, 6632.966835165793, 6664.7000884959325, 6669.833254168685, 6671.3995740382625, 1678.211240716861, 1695.6693444778396, 1696.4825728152784, 1701.038913014143, 1702.6169111949712, 1094.4473041114186, 1106.5020740666732, 1123.2361993844102, 1138.59579849154, 1152.9162587168034, 6333.96833015832, 6337.809865703944, 6338.366163383625, 6350.333215012357, 6352.396522330371, 6790.287019862942, 6832.760853370109, 6865.725370985105, 6867.965660171667, 6876.931230687729, 6191.876162476725, 6267.341929097471, 6310.968445157745, 6376.692777980503, 6395.008773640093, 3689.040849379127, 3696.5748938871834, 3713.9442908356395, 3718.572364178154, 3725.590185079693, 7162.176349719744, 7199.568025918462, 7226.5664060155505, 7242.45681573884, 7255.709771609182, 6952.930470695228, 7023.122109736283, 7049.7885063448175, 7104.538205016657, 7117.857642847218, 7263.673134708951, 7271.127464704269, 7312.1956584775635, 7339.853202935911, 7342.045534080428, 6918.342757438036, 6933.0, 6933.930660693329, 6947.305269473012, 6962.0, 6657.7669781557415, 6827.21487028998, 6837.829054273484, 6848.2124555674745, 6859.348361905611, 7197.568145911262, 7215.530990485601, 7221.783346499614, 7224.819379515554, 7242.348188663045, 4581.908361832811, 4620.5841474266135, 4628.236341003697, 4629.398178236807, 4637.188492013952, 6829.1611769872325, 6835.863282734417, 6936.0636314096955, 6940.41006514452, 6951.16586009682, 6699.162604674416, 6705.9605761107105, 6707.295733947865, 6712.966435167793, 6713.6307503085845, 6592.143021407186, 6658.966705166443, 6671.199456065303, 6698.7320507179165, 6762.49281303914, 6515.381038801306, 6532.216134063943, 6553.639549824806, 6563.1796025496815, 6587.242467116343, 6684.398404143456, 6696.698648560924, 6711.0, 6715.93284067153, 6717.05961165447, 6455.3221911700475, 6574.605523668595, 6583.473322134314, 6585.0574080645365, 6595.175603049619], "unit": "score", "name": "prototype.html", "value": 4988.105271606905}, {"lowerIsBetter": false, "replicates": [696.2132789947359, 765.9157492675805, 814.4583851738598, 833.4166083741379, 858.4806192253691, 12796.296203708793, 12957.35213239339, 13058.0, 13067.019973501978, 13080.60758177255, 10862.34825910446, 11972.580959666413, 12004.339761313124, 12046.759064818698, 12310.384480775947, 798.876174193001, 804.947678400905, 807.3541167066353, 807.6527093349857, 808.9595520223995, 799.5482552357928, 807.2694211738386, 807.6042739057879, 808.337163525909, 809.4738420026971, 829.0548774397192, 830.904445988713, 833.6123702478346, 838.4256784102879, 839.5844057191699, 823.5882058970515, 829.0341751859077, 832.5670651261311, 832.7127141136298, 834.7996480844583, 595.9046552551571, 606.3572613030202, 607.2227548737623, 610.2372034956304, 610.4140025575452, 12476.937615311865, 12619.179753316097, 12640.178388404816, 12757.74484510314, 12771.233725976472, 11878.524859005629, 12063.698407539794, 12180.81728774069, 12334.198277111958, 12531.373431328397, 9586.424814511152, 9654.22766178704, 9787.706368808947, 10127.746806329827, 10134.13859821916, 3530.6998905093096, 3571.160777217352, 3596.352656521825, 3598.316319899237, 3619.0771353305004, 44457.3331400026, 44461.333080003824, 44467.555324446665, 44599.331010034875, 45086.77456612696, 9019.413738107001, 9028.09719028092, 9221.81556368869, 9234.122758337948, 9362.531873406302, 15682.921585392, 15880.126593037263, 16392.918035409984, 16470.09414482215, 16611.169441527876, 7042.295770422917, 7074.858502830018, 7105.111861017373, 7130.322619351154, 7131.0373099631925, 4006.1386801837743, 4033.1127152026506, 4146.37804329353, 4198.895027624334, 4206.348016057516, 3031.621047369079, 3052.0, 3085.568020477135, 3085.6760040195904, 3097.303106800997, 566.2412367427667, 577.9971100144472, 578.2684903596953, 578.2684903596953, 578.8205656246577, 511.0902593383783, 522.5427750718121, 523.6779380680854, 529.8781280305551, 530.2867643020131, 7815.25755053269, 8016.959915200387, 8081.959590202011, 8089.595520223966, 8419.663213471515, 615.4399496458202, 621.5269810548938, 663.6947004377944, 682.382443888282, 711.434409644334, 3921.9019524511546, 3955.980220098881, 3985.20295940813, 4004.150826673027, 4114.835406583763, 58310.125348119815, 58532.0, 58657.0, 58906.0, 59134.704326478095, 49197.50802492001, 50309.0, 50883.745581271854, 51428.11432913867, 51631.0, 42643.78678106589, 43397.0, 44904.77547612241, 45401.31898021532, 45787.54212457899, 7986.680532778624, 7996.5601891894175, 8328.958355208186, 8409.915900841159, 8602.741917742478, 32972.67027329696, 33917.0, 35109.297814043064, 36913.07717307089, 37442.812785935894, 40472.1905561893, 41198.58801411947, 42308.57691423046, 46854.29718554156, 47685.0, 10729.517171727135, 10755.408452535186, 10889.401082940514, 11043.558257669603, 11166.162537809534, 11855.407229638311, 11877.346745929057, 12030.939845300718, 12050.879491204976, 12354.492632914807, 11113.166512511756, 11188.66434006981, 11211.271267367594, 11236.438178090899, 11816.025707679102, 10704.225352112613, 10755.0, 10775.892241077489, 10866.239363244496, 10872.67381978542, 9867.605295788087, 9941.353812002197, 10184.879663237187, 10333.966603339606, 10374.844377334497, 9155.542222888962, 9237.630494780133, 9545.236381089635, 9565.0, 9795.314327996972, 8539.573021349031, 8662.523561204194, 8749.650013999624, 8847.601857916537, 9074.90925090767], "unit": "score", "name": "yui.html", "value": 6072.935187942277}], "name": "dromaeo_css", "value": 6759.45354005161}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 112.0, 112.0, 124.0, 111.0, 113.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [162.0, 128.0, 153.0, 171.0, 126.0, 152.0, 152.0, 134.0, 171.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 164.0, 160.0, 161.0, 161.0, 165.0, 167.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 73.0, 73.0, 73.0, 142.0, 73.0, 74.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 142.0, 96.0, 96.0, 97.0, 139.0, 96.0, 98.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 109.0, 109.0, 111.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 149.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [63.0, 60.0, 59.0, 59.0, 60.0, 60.0, 64.0, 58.0, 68.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 72.0, 68.0, 70.0, 68.0, 67.0, 68.0, 71.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [81.0, 89.0, 86.0, 83.0, 83.0, 82.0, 82.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [118.0, 131.0, 116.0, 112.0, 113.0, 119.0, 120.0, 120.0, 124.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [127.0, 140.0, 142.0, 140.0, 141.0, 139.0, 145.0, 143.0, 139.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 68.0, 70.0, 69.0, 69.0, 69.0, 68.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1505.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.30633627141194], "unit": "score", "name": "Richards", "value": 212.27092600000003}, {"lowerIsBetter": false, "replicates": [197.7456990310461], "unit": "score", "name": "DeltaBlue", "value": 334.35872600000005}, {"lowerIsBetter": false, "replicates": [284.3332385555872], "unit": "score", "name": "Encrypt", "value": 936.1585769999997}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [748.502994011976], "unit": "score", "name": "Earley", "value": 890.3945680000003}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [42750.0], "unit": "score", "name": "RegExp", "value": 21.30959064327485}, {"lowerIsBetter": false, "replicates": [578.0346820809249], "unit": "score", "name": "Splay", "value": 140.97942999999995}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20145.072916901063}]} 09:20:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20145.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1505.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6759.45"}}} 09:20:36 INFO - Return code: 0 09:20:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:20:36 INFO - # TBPL SUCCESS # 09:20:36 INFO - Running post-action listener: _resource_record_post_action 09:20:36 INFO - Running post-run listener: _resource_record_post_run 09:20:37 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 8192; Write bytes: 549679104; Read time: 156; Write time: 516972 09:20:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236355584; Read time: 0; Write time: 333580 09:20:37 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8192; Write bytes: 313147392; Read time: 156; Write time: 183360 09:20:37 INFO - Running post-run listener: _upload_blobber_files 09:20:37 INFO - Blob upload gear active. 09:20:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:20:37 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:20:37 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:20:37 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:20:38 INFO - (blobuploader) - INFO - Open directory for files ... 09:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:38 INFO - (blobuploader) - INFO - Done attempting. 09:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:20:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:39 INFO - (blobuploader) - INFO - Done attempting. 09:20:39 INFO - (blobuploader) - INFO - Iteration through files over. 09:20:39 INFO - Return code: 0 09:20:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:20:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:20:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af22faa1ffd52315f1864ee7d7e6c583ffecc4e1e517c622bf9bf48fdac66136061a62db7e2f5029bd057566d31784b065427d07772330b1351d3f1a91ee86d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf513e6cf2c3c332c8aa9374ee003e561abed2b25f1339c6f587152fd2769a3e2d30e1f991a5a1aef0ca5faa6954993439f034239349f792e4588a0314f5cd45"} 09:20:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:20:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:20:39 INFO - Contents: 09:20:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af22faa1ffd52315f1864ee7d7e6c583ffecc4e1e517c622bf9bf48fdac66136061a62db7e2f5029bd057566d31784b065427d07772330b1351d3f1a91ee86d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf513e6cf2c3c332c8aa9374ee003e561abed2b25f1339c6f587152fd2769a3e2d30e1f991a5a1aef0ca5faa6954993439f034239349f792e4588a0314f5cd45"} 09:20:39 INFO - Running post-run listener: copy_logs_to_upload_dir 09:20:39 INFO - Copying logs to upload dir... 09:20:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:20:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.734427 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-01-26 09:20:39.784974) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-26 09:20:39.789875) ========= 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=d2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af22faa1ffd52315f1864ee7d7e6c583ffecc4e1e517c622bf9bf48fdac66136061a62db7e2f5029bd057566d31784b065427d07772330b1351d3f1a91ee86d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf513e6cf2c3c332c8aa9374ee003e561abed2b25f1339c6f587152fd2769a3e2d30e1f991a5a1aef0ca5faa6954993439f034239349f792e4588a0314f5cd45"} 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.011434 build_url: 'https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af22faa1ffd52315f1864ee7d7e6c583ffecc4e1e517c622bf9bf48fdac66136061a62db7e2f5029bd057566d31784b065427d07772330b1351d3f1a91ee86d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf513e6cf2c3c332c8aa9374ee003e561abed2b25f1339c6f587152fd2769a3e2d30e1f991a5a1aef0ca5faa6954993439f034239349f792e4588a0314f5cd45"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-26 09:20:39.817727) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:20:39.818105) ========= 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=d2a8c569965ab8367867b893000001a1-1453826416.385370-1335229897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:20:39.898450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 09:20:39.898760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 09:20:39.899037) ========= ========= Total master_lag: 0.32 =========