builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1453124592.78 results: success (0) buildid: 20160118030338 builduid: 0a5e205caf7d409abe99b6c39d516406 revision: 8cb42e7a16b42162c9930f37b9e1f820c2eb126b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:12.782609) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:12.783338) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:12.783739) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006358 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:12.873803) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:12.874112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:12.977345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:12.977644) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013884 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:13.053692) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:13.053991) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:13.054360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:13.054684) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 05:43: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% 210M=0s 2016-01-18 05:43:13 (210 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:13.238806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:13.239121) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.153055 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:13.411355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:13.411719) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8cb42e7a16b42162c9930f37b9e1f820c2eb126b --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 8cb42e7a16b42162c9930f37b9e1f820c2eb126b --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=b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 05:43:13,528 truncating revision to first 12 chars 2016-01-18 05:43:13,528 Setting DEBUG logging. 2016-01-18 05:43:13,528 attempt 1/10 2016-01-18 05:43:13,528 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8cb42e7a16b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 05:43:13,802 unpacking tar archive at: mozilla-central-8cb42e7a16b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:13.999641) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:14.000354) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004924 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:14.053897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:14.054613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:14.074926) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:14.075230) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 05:43:14.075642) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 17 secs) (at 2016-01-18 05:43:14.075990) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:43:14 INFO - MultiFileLogger online at 20160118 05:43:14 in /builds/slave/test-pgo 05:43:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:43:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:43:14 INFO - {'append_to_log': False, 05:43:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:43:14 INFO - 'blob_upload_branch': 'Firefox', 05:43:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:43:14 INFO - 'branch': 'Firefox', 05:43:14 INFO - 'buildbot_json_path': 'buildprops.json', 05:43:14 INFO - 'config_files': ('talos/linux_config.py',), 05:43:14 INFO - 'default_actions': ('clobber', 05:43:14 INFO - 'read-buildbot-config', 05:43:14 INFO - 'download-and-extract', 05:43:14 INFO - 'populate-webroot', 05:43:14 INFO - 'create-virtualenv', 05:43:14 INFO - 'install', 05:43:14 INFO - 'run-tests'), 05:43:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:43:14 INFO - 'download_minidump_stackwalk': True, 05:43:14 INFO - 'download_symbols': 'ondemand', 05:43:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:43:14 INFO - 'tooltool.py': '/tools/tooltool.py', 05:43:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:43:14 INFO - '/tools/misc-python/virtualenv.py')}, 05:43:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:43:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:43:14 INFO - 'installer_path': 'installer.exe', 05:43:14 INFO - 'log_level': 'info', 05:43:14 INFO - 'log_name': 'talos', 05:43:14 INFO - 'log_to_console': True, 05:43:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:43:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:43:14 INFO - 'opt_config_files': (), 05:43:14 INFO - 'pip_index': False, 05:43:14 INFO - 'sps_profile': False, 05:43:14 INFO - 'sps_profile_interval': 0, 05:43:14 INFO - 'suite': 'dromaeojs-e10s', 05:43:14 INFO - 'system_bits': '32', 05:43:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:43:14 INFO - 'title': 'talos-linux64-ix-007', 05:43:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:43:14 INFO - 'use_talos_json': True, 05:43:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:43:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:43:14 INFO - 'work_dir': 'build'} 05:43:14 INFO - ##### 05:43:14 INFO - ##### Running clobber step. 05:43:14 INFO - ##### 05:43:14 INFO - Running pre-action listener: _resource_record_pre_action 05:43:14 INFO - Running main action method: clobber 05:43:14 INFO - rmtree: /builds/slave/test-pgo/build 05:43:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:43:18 INFO - Running post-action listener: _resource_record_post_action 05:43:18 INFO - ##### 05:43:18 INFO - ##### Running read-buildbot-config step. 05:43:18 INFO - ##### 05:43:18 INFO - Running pre-action listener: _resource_record_pre_action 05:43:18 INFO - Running main action method: read_buildbot_config 05:43:18 INFO - Using buildbot properties: 05:43:18 INFO - { 05:43:18 INFO - "project": "", 05:43:18 INFO - "product": "firefox", 05:43:18 INFO - "script_repo_revision": "production", 05:43:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:43:18 INFO - "repository": "", 05:43:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:43:18 INFO - "buildid": "20160118030338", 05:43:18 INFO - "stage_platform": "linux64-pgo", 05:43:18 INFO - "basedir": "/builds/slave/test-pgo", 05:43:18 INFO - "nightly_build": "True", 05:43:18 INFO - "buildnumber": 309, 05:43:18 INFO - "slavename": "talos-linux64-ix-007", 05:43:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:43:18 INFO - "platform": "ubuntu64_hw", 05:43:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:43:18 INFO - "branch": "mozilla-central", 05:43:18 INFO - "repo_path": "mozilla-central", 05:43:18 INFO - "revision": "8cb42e7a16b42162c9930f37b9e1f820c2eb126b", 05:43:18 INFO - "pgo_build": "True", 05:43:18 INFO - "builduid": "0a5e205caf7d409abe99b6c39d516406", 05:43:18 INFO - "slavebuilddir": "test" 05:43:18 INFO - } 05:43:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:43:18 INFO - Running post-action listener: _resource_record_post_action 05:43:18 INFO - ##### 05:43:18 INFO - ##### Running download-and-extract step. 05:43:18 INFO - ##### 05:43:18 INFO - Running pre-action listener: _resource_record_pre_action 05:43:18 INFO - Running main action method: download_and_extract 05:43:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:18 INFO - https://queue.taskcluster.net/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:43:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/test_packages.json 05:43:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/test_packages.json 05:43:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:43:20 INFO - Downloaded 1448 bytes. 05:43:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:43:20 INFO - Using the following test package requirements: 05:43:20 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:20 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:20 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:43:20 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:20 INFO - u'jsshell-linux-x86_64.zip'], 05:43:20 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:20 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:20 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:43:20 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:43:20 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:20 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:20 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:20 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:20 INFO - https://queue.taskcluster.net/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:24 INFO - Downloaded 22484230 bytes. 05:43:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:43:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:43:25 INFO - Return code: 0 05:43:25 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:25 INFO - https://queue.taskcluster.net/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:28 INFO - Downloaded 22484230 bytes. 05:43:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:43:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:43:29 INFO - Return code: 0 05:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:29 INFO - https://queue.taskcluster.net/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:43:32 INFO - Downloaded 11132144 bytes. 05:43:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:43:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:43:32 INFO - Return code: 0 05:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:32 INFO - https://queue.taskcluster.net/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:43:40 INFO - Downloaded 55960373 bytes. 05:43:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:40 INFO - mkdir: /builds/slave/test-pgo/properties 05:43:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:43:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:43:40 INFO - Contents: 05:43:40 INFO - build_url:https://queue.taskcluster.net/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:40 INFO - Running post-action listener: _resource_record_post_action 05:43:40 INFO - Running post-action listener: set_extra_try_arguments 05:43:40 INFO - ##### 05:43:40 INFO - ##### Running populate-webroot step. 05:43:40 INFO - ##### 05:43:40 INFO - Running pre-action listener: _resource_record_pre_action 05:43:40 INFO - Running main action method: populate_webroot 05:43:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:40 INFO - '--tppagecycles', 05:43:40 INFO - '7'], 05:43:40 INFO - 'tests': ['tsvgm']}}, 05:43:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:43:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:43:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:43:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'tests': ['damp', 'tps']}, 05:43:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['damp', 'tps']}, 05:43:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:43:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:40 INFO - 'other': {'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'other_l64': {'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'other_nol64': {'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'svgr': {'tests': ['tsvgx', 05:43:40 INFO - 'tsvgr_opacity', 05:43:40 INFO - 'tart', 05:43:40 INFO - 'tscrollx', 05:43:40 INFO - 'cart']}, 05:43:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['tsvgx', 05:43:40 INFO - 'tsvgr_opacity', 05:43:40 INFO - 'tart', 05:43:40 INFO - 'tscrollx', 05:43:40 INFO - 'cart']}, 05:43:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'tests': ['tp5o']}, 05:43:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['tp5o']}, 05:43:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--xperf_path', 05:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:40 INFO - 'tests': ['tp5n']}, 05:43:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--e10s', 05:43:40 INFO - '--xperf_path', 05:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:40 INFO - 'tests': ['tp5n']}}, 05:43:40 INFO - 'talos.zip': {'path': '', 05:43:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:40 INFO - Running post-action listener: _resource_record_post_action 05:43:40 INFO - ##### 05:43:40 INFO - ##### Running create-virtualenv step. 05:43:40 INFO - ##### 05:43:40 INFO - Running pre-action listener: _resource_record_pre_action 05:43:40 INFO - Running main action method: create_virtualenv 05:43:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:43:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:43:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:43:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:40 INFO - Using real prefix '/usr' 05:43:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:43:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:43 INFO - Installing pip.................done. 05:43:43 INFO - Return code: 0 05:43:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38194bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9840>, '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 0xd466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd46b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:43:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:43:43 INFO - Using env: {'DISPLAY': ':0', 05:43:43 INFO - 'HOME': '/home/cltbld', 05:43:43 INFO - 'LANG': 'en_US.UTF-8', 05:43:43 INFO - 'LANGUAGE': 'en_US:en', 05:43:43 INFO - 'LOGNAME': 'cltbld', 05:43:43 INFO - 'MAIL': '/var/mail/cltbld', 05:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:43 INFO - 'MOZ_NO_REMOTE': '1', 05:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:43 INFO - 'NO_EM_RESTART': '1', 05:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:43 INFO - 'SHELL': '/bin/bash', 05:43:43 INFO - 'SHLVL': '1', 05:43:43 INFO - 'TERM': 'linux', 05:43:43 INFO - 'TMOUT': '86400', 05:43:43 INFO - 'USER': 'cltbld', 05:43:43 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 05:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:43 INFO - '_': '/tools/buildbot/bin/python'} 05:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:43:43 INFO - Cleaning up... 05:43:43 INFO - Return code: 0 05:43:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38194bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9840>, '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 0xd466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd46b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:43:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:43:43 INFO - Using env: {'DISPLAY': ':0', 05:43:43 INFO - 'HOME': '/home/cltbld', 05:43:43 INFO - 'LANG': 'en_US.UTF-8', 05:43:43 INFO - 'LANGUAGE': 'en_US:en', 05:43:43 INFO - 'LOGNAME': 'cltbld', 05:43:43 INFO - 'MAIL': '/var/mail/cltbld', 05:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:43 INFO - 'MOZ_NO_REMOTE': '1', 05:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:43 INFO - 'NO_EM_RESTART': '1', 05:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:43 INFO - 'SHELL': '/bin/bash', 05:43:43 INFO - 'SHLVL': '1', 05:43:43 INFO - 'TERM': 'linux', 05:43:43 INFO - 'TMOUT': '86400', 05:43:43 INFO - 'USER': 'cltbld', 05:43:43 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 05:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:43 INFO - '_': '/tools/buildbot/bin/python'} 05:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:43 INFO - Downloading/unpacking psutil>=0.7.1 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:43:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:43:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:45 INFO - Installing collected packages: psutil 05:43:45 INFO - Running setup.py install for psutil 05:43:45 INFO - building 'psutil._psutil_linux' extension 05:43:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:43:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:43:45 INFO - building 'psutil._psutil_posix' extension 05:43:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:43:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:43:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:46 INFO - Successfully installed psutil 05:43:46 INFO - Cleaning up... 05:43:46 INFO - Return code: 0 05:43:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38194bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9840>, '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 0xd466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd46b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:43:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:43:46 INFO - Using env: {'DISPLAY': ':0', 05:43:46 INFO - 'HOME': '/home/cltbld', 05:43:46 INFO - 'LANG': 'en_US.UTF-8', 05:43:46 INFO - 'LANGUAGE': 'en_US:en', 05:43:46 INFO - 'LOGNAME': 'cltbld', 05:43:46 INFO - 'MAIL': '/var/mail/cltbld', 05:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:46 INFO - 'MOZ_NO_REMOTE': '1', 05:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:46 INFO - 'NO_EM_RESTART': '1', 05:43:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:46 INFO - 'SHELL': '/bin/bash', 05:43:46 INFO - 'SHLVL': '1', 05:43:46 INFO - 'TERM': 'linux', 05:43:46 INFO - 'TMOUT': '86400', 05:43:46 INFO - 'USER': 'cltbld', 05:43:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 05:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:46 INFO - '_': '/tools/buildbot/bin/python'} 05:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:43:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:43:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:43:48 INFO - Installing collected packages: mozsystemmonitor 05:43:48 INFO - Running setup.py install for mozsystemmonitor 05:43:48 INFO - Successfully installed mozsystemmonitor 05:43:48 INFO - Cleaning up... 05:43:48 INFO - Return code: 0 05:43:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:43: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')]} 05:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38194bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9840>, '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 0xd466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd46b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:43:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:43:48 INFO - Using env: {'DISPLAY': ':0', 05:43:48 INFO - 'HOME': '/home/cltbld', 05:43:48 INFO - 'LANG': 'en_US.UTF-8', 05:43:48 INFO - 'LANGUAGE': 'en_US:en', 05:43:48 INFO - 'LOGNAME': 'cltbld', 05:43:48 INFO - 'MAIL': '/var/mail/cltbld', 05:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:48 INFO - 'MOZ_NO_REMOTE': '1', 05:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:48 INFO - 'NO_EM_RESTART': '1', 05:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:48 INFO - 'SHELL': '/bin/bash', 05:43:48 INFO - 'SHLVL': '1', 05:43:48 INFO - 'TERM': 'linux', 05:43:48 INFO - 'TMOUT': '86400', 05:43:48 INFO - 'USER': 'cltbld', 05:43:48 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 05:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:48 INFO - '_': '/tools/buildbot/bin/python'} 05:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:43:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:43:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:43:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:50 INFO - Downloading docopt-0.6.1.tar.gz 05:43:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:43:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:50 INFO - Running setup.py install for blobuploader 05:43:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:43:50 INFO - Running setup.py install for requests 05:43:51 INFO - Running setup.py install for docopt 05:43:51 INFO - Successfully installed blobuploader requests docopt 05:43:51 INFO - Cleaning up... 05:43:51 INFO - Return code: 0 05:43:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38194bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9840>, '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 0xd466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd46b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:43:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:51 INFO - Using env: {'DISPLAY': ':0', 05:43:51 INFO - 'HOME': '/home/cltbld', 05:43:51 INFO - 'LANG': 'en_US.UTF-8', 05:43:51 INFO - 'LANGUAGE': 'en_US:en', 05:43:51 INFO - 'LOGNAME': 'cltbld', 05:43:51 INFO - 'MAIL': '/var/mail/cltbld', 05:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:51 INFO - 'MOZ_NO_REMOTE': '1', 05:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:51 INFO - 'NO_EM_RESTART': '1', 05:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:51 INFO - 'SHELL': '/bin/bash', 05:43:51 INFO - 'SHLVL': '1', 05:43:51 INFO - 'TERM': 'linux', 05:43:51 INFO - 'TMOUT': '86400', 05:43:51 INFO - 'USER': 'cltbld', 05:43:51 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 05:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:51 INFO - '_': '/tools/buildbot/bin/python'} 05:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:51 INFO - Running setup.py (path:/tmp/pip-w97T6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:51 INFO - Running setup.py (path:/tmp/pip-6Ijs1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:51 INFO - Running setup.py (path:/tmp/pip-o9O7b2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:51 INFO - Running setup.py (path:/tmp/pip-kq3RD9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:51 INFO - Running setup.py (path:/tmp/pip-sl9eqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:52 INFO - Running setup.py (path:/tmp/pip-4KELY9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:52 INFO - Running setup.py (path:/tmp/pip-lRoXSi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:52 INFO - Running setup.py (path:/tmp/pip-MzDn1s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:52 INFO - Running setup.py (path:/tmp/pip-epA4pX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:52 INFO - Running setup.py (path:/tmp/pip-G2TQh9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:52 INFO - Running setup.py (path:/tmp/pip-yKodmY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:52 INFO - Running setup.py (path:/tmp/pip-CxsP4i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:52 INFO - Running setup.py (path:/tmp/pip-Cu50ns-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:52 INFO - Running setup.py (path:/tmp/pip-u6biFZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:52 INFO - Running setup.py (path:/tmp/pip-Ubjino-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:52 INFO - Running setup.py (path:/tmp/pip-eWBQo1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:52 INFO - Running setup.py (path:/tmp/pip-TaLbfQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:52 INFO - Running setup.py install for manifestparser 05:43:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozcrash 05:43:53 INFO - Running setup.py install for mozdebug 05:43:53 INFO - Running setup.py install for mozdevice 05:43:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozfile 05:43:53 INFO - Running setup.py install for mozhttpd 05:43:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozinfo 05:43:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozInstall 05:43:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozleak 05:43:53 INFO - Running setup.py install for mozlog 05:43:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for moznetwork 05:43:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Running setup.py install for mozprocess 05:43:54 INFO - Running setup.py install for mozprofile 05:43:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Running setup.py install for mozrunner 05:43:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Running setup.py install for mozscreenshot 05:43:54 INFO - Running setup.py install for moztest 05:43:54 INFO - Running setup.py install for mozversion 05:43:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:54 INFO - Cleaning up... 05:43:54 INFO - Return code: 0 05:43:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38194bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9840>, '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 0xd466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd46b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:43:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:54 INFO - Using env: {'DISPLAY': ':0', 05:43:54 INFO - 'HOME': '/home/cltbld', 05:43:54 INFO - 'LANG': 'en_US.UTF-8', 05:43:54 INFO - 'LANGUAGE': 'en_US:en', 05:43:54 INFO - 'LOGNAME': 'cltbld', 05:43:54 INFO - 'MAIL': '/var/mail/cltbld', 05:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:54 INFO - 'MOZ_NO_REMOTE': '1', 05:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:54 INFO - 'NO_EM_RESTART': '1', 05:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:54 INFO - 'SHELL': '/bin/bash', 05:43:54 INFO - 'SHLVL': '1', 05:43:54 INFO - 'TERM': 'linux', 05:43:54 INFO - 'TMOUT': '86400', 05:43:54 INFO - 'USER': 'cltbld', 05:43:54 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 05:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:54 INFO - '_': '/tools/buildbot/bin/python'} 05:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:54 INFO - Running setup.py (path:/tmp/pip-qpciM8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:54 INFO - Running setup.py (path:/tmp/pip-4SxgpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:55 INFO - Running setup.py (path:/tmp/pip-2rOQED-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:55 INFO - Running setup.py (path:/tmp/pip-F0O7zI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:55 INFO - Running setup.py (path:/tmp/pip-wQRwmA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:55 INFO - Running setup.py (path:/tmp/pip-tgylnB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:55 INFO - Running setup.py (path:/tmp/pip-GMSAuG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:55 INFO - Running setup.py (path:/tmp/pip-9ns2xe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:55 INFO - Running setup.py (path:/tmp/pip-ryWng_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:55 INFO - Running setup.py (path:/tmp/pip-x6BnfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:55 INFO - Running setup.py (path:/tmp/pip-NSznyW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:55 INFO - Running setup.py (path:/tmp/pip-1DQtO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:55 INFO - Running setup.py (path:/tmp/pip-8wEVsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:55 INFO - Running setup.py (path:/tmp/pip-uPMBoD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:55 INFO - Running setup.py (path:/tmp/pip-9v_kUz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:43:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:56 INFO - Running setup.py (path:/tmp/pip-6ZthAP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:43:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:56 INFO - Running setup.py (path:/tmp/pip-zrYp5G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:57 INFO - Downloading blessings-1.5.1.tar.gz 05:43:57 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:43:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:57 INFO - Installing collected packages: blessings 05:43:57 INFO - Running setup.py install for blessings 05:43:58 INFO - Successfully installed blessings 05:43:58 INFO - Cleaning up... 05:43:58 INFO - Return code: 0 05:43:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:43:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:43:58 INFO - Reading from file tmpfile_stdout 05:43:58 INFO - Current package versions: 05:43:58 INFO - argparse == 1.2.1 05:43:58 INFO - blessings == 1.5.1 05:43:58 INFO - blobuploader == 1.2.4 05:43:58 INFO - docopt == 0.6.1 05:43:58 INFO - manifestparser == 1.1 05:43:58 INFO - mozInstall == 1.12 05:43:58 INFO - mozcrash == 0.16 05:43:58 INFO - mozdebug == 0.1 05:43:58 INFO - mozdevice == 0.48 05:43:58 INFO - mozfile == 1.2 05:43:58 INFO - mozhttpd == 0.7 05:43:58 INFO - mozinfo == 0.9 05:43:58 INFO - mozleak == 0.1 05:43:58 INFO - mozlog == 3.1 05:43:58 INFO - moznetwork == 0.27 05:43:58 INFO - mozprocess == 0.22 05:43:58 INFO - mozprofile == 0.28 05:43:58 INFO - mozrunner == 6.11 05:43:58 INFO - mozscreenshot == 0.1 05:43:58 INFO - mozsystemmonitor == 0.0 05:43:58 INFO - moztest == 0.7 05:43:58 INFO - mozversion == 1.4 05:43:58 INFO - psutil == 3.1.1 05:43:58 INFO - requests == 1.2.3 05:43:58 INFO - wsgiref == 0.1.2 05:43:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38194bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9840>, '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 0xd466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd46b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:58 INFO - Using env: {'DISPLAY': ':0', 05:43:58 INFO - 'HOME': '/home/cltbld', 05:43:58 INFO - 'LANG': 'en_US.UTF-8', 05:43:58 INFO - 'LANGUAGE': 'en_US:en', 05:43:58 INFO - 'LOGNAME': 'cltbld', 05:43:58 INFO - 'MAIL': '/var/mail/cltbld', 05:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:58 INFO - 'MOZ_NO_REMOTE': '1', 05:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:58 INFO - 'NO_EM_RESTART': '1', 05:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:58 INFO - 'SHELL': '/bin/bash', 05:43:58 INFO - 'SHLVL': '1', 05:43:58 INFO - 'TERM': 'linux', 05:43:58 INFO - 'TMOUT': '86400', 05:43:58 INFO - 'USER': 'cltbld', 05:43:58 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 05:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:58 INFO - '_': '/tools/buildbot/bin/python'} 05:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:43:58 INFO - Cleaning up... 05:43:58 INFO - Return code: 0 05:43:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38194bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9840>, '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 0xd466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd46b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:43:58 INFO - Using env: {'DISPLAY': ':0', 05:43:58 INFO - 'HOME': '/home/cltbld', 05:43:58 INFO - 'LANG': 'en_US.UTF-8', 05:43:58 INFO - 'LANGUAGE': 'en_US:en', 05:43:58 INFO - 'LOGNAME': 'cltbld', 05:43:58 INFO - 'MAIL': '/var/mail/cltbld', 05:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:58 INFO - 'MOZ_NO_REMOTE': '1', 05:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:58 INFO - 'NO_EM_RESTART': '1', 05:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:58 INFO - 'SHELL': '/bin/bash', 05:43:58 INFO - 'SHLVL': '1', 05:43:58 INFO - 'TERM': 'linux', 05:43:58 INFO - 'TMOUT': '86400', 05:43:58 INFO - 'USER': 'cltbld', 05:43:58 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 05:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:58 INFO - '_': '/tools/buildbot/bin/python'} 05:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:58 INFO - Downloading/unpacking jsonschema 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:44:00 INFO - Downloading/unpacking functools32 (from jsonschema) 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:44:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:44:00 INFO - warning: no files found matching '*.txt' 05:44:00 INFO - no previously-included directories found matching 'build' 05:44:00 INFO - no previously-included directories found matching 'dist' 05:44:00 INFO - no previously-included directories found matching '.git*' 05:44:00 INFO - Installing collected packages: jsonschema, functools32 05:44:00 INFO - Running setup.py install for functools32 05:44:00 INFO - warning: no files found matching '*.txt' 05:44:00 INFO - no previously-included directories found matching 'build' 05:44:00 INFO - no previously-included directories found matching 'dist' 05:44:00 INFO - no previously-included directories found matching '.git*' 05:44:00 INFO - Successfully installed jsonschema functools32 05:44:00 INFO - Cleaning up... 05:44:00 INFO - Return code: 0 05:44:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38194bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd9840>, '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 0xd466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd46b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:44:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:44:00 INFO - Using env: {'DISPLAY': ':0', 05:44:00 INFO - 'HOME': '/home/cltbld', 05:44:00 INFO - 'LANG': 'en_US.UTF-8', 05:44:00 INFO - 'LANGUAGE': 'en_US:en', 05:44:00 INFO - 'LOGNAME': 'cltbld', 05:44:00 INFO - 'MAIL': '/var/mail/cltbld', 05:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:00 INFO - 'MOZ_NO_REMOTE': '1', 05:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:00 INFO - 'NO_EM_RESTART': '1', 05:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:00 INFO - 'SHELL': '/bin/bash', 05:44:00 INFO - 'SHLVL': '1', 05:44:00 INFO - 'TERM': 'linux', 05:44:00 INFO - 'TMOUT': '86400', 05:44:00 INFO - 'USER': 'cltbld', 05:44:00 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 05:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:00 INFO - '_': '/tools/buildbot/bin/python'} 05:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:01 INFO - Downloading/unpacking flake8 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:44:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:44:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:44:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:44:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:44:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:44:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:44:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:03 INFO - no previously-included directories found matching 'docs/_build' 05:44:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:44:03 INFO - Running setup.py install for pep8 05:44:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:03 INFO - no previously-included directories found matching 'docs/_build' 05:44:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:44:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:44:03 INFO - Cleaning up... 05:44:03 INFO - Return code: 0 05:44:03 INFO - Running post-action listener: _resource_record_post_action 05:44:03 INFO - Running post-action listener: _start_resource_monitoring 05:44:03 INFO - Starting resource monitoring. 05:44:03 INFO - ##### 05:44:03 INFO - ##### Running install step. 05:44:03 INFO - ##### 05:44:03 INFO - Running pre-action listener: _resource_record_pre_action 05:44:03 INFO - Running main action method: install 05:44:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:44:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:44:04 INFO - Reading from file tmpfile_stdout 05:44:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:44:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:44:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:44:04 INFO - Reading from file tmpfile_stdout 05:44:04 INFO - Output received: 05:44:04 INFO - Usage: mozinstall [options] installer 05:44:04 INFO - Options: 05:44:04 INFO - -h, --help show this help message and exit 05:44:04 INFO - -d DEST, --destination=DEST 05:44:04 INFO - Directory to install application into. [default: 05:44:04 INFO - "/builds/slave/test-pgo"] 05:44:04 INFO - --app=APP Application being installed. [default: firefox] 05:44:04 INFO - mkdir: /builds/slave/test-pgo/build/application 05:44:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:44:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:44:20 INFO - Reading from file tmpfile_stdout 05:44:20 INFO - Output received: 05:44:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:44:20 INFO - Running post-action listener: _resource_record_post_action 05:44:20 INFO - ##### 05:44:20 INFO - ##### Running run-tests step. 05:44:20 INFO - ##### 05:44:20 INFO - Running pre-action listener: _resource_record_pre_action 05:44:20 INFO - Running main action method: run_tests 05:44:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:44:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:44:20 INFO - Python 2.7.3 05:44:20 INFO - Return code: 0 05:44:20 INFO - grabbing minidump binary from tooltool 05:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:20 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 0xdd9840>, '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 0xd466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd46b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:44:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:44:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:44:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:20 INFO - Return code: 0 05:44:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:44:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:44:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:44:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:44:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:44:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:44:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:44:21 INFO - Return code: 0 05:44:21 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/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:44:21 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/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:44:21 INFO - Using env: {'DISPLAY': ':0', 05:44:21 INFO - 'HOME': '/home/cltbld', 05:44:21 INFO - 'LANG': 'en_US.UTF-8', 05:44:21 INFO - 'LANGUAGE': 'en_US:en', 05:44:21 INFO - 'LOGNAME': 'cltbld', 05:44:21 INFO - 'MAIL': '/var/mail/cltbld', 05:44:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:44:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:21 INFO - 'MOZ_NO_REMOTE': '1', 05:44:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:21 INFO - 'NO_EM_RESTART': '1', 05:44:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:44:21 INFO - 'SHELL': '/bin/bash', 05:44:21 INFO - 'SHLVL': '1', 05:44:21 INFO - 'TERM': 'linux', 05:44:21 INFO - 'TMOUT': '86400', 05:44:21 INFO - 'USER': 'cltbld', 05:44:21 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496', 05:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:21 INFO - '_': '/tools/buildbot/bin/python'} 05:44:21 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/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:44:21 INFO - mozversion application_buildid: 20160118030338 05:44:21 INFO - mozversion application_changeset: 8cb42e7a16b42162c9930f37b9e1f820c2eb126b 05:44:21 INFO - mozversion application_display_name: Nightly 05:44:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:21 INFO - mozversion application_name: Firefox 05:44:21 INFO - mozversion application_remotingname: firefox 05:44:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:44:21 INFO - mozversion application_vendor: Mozilla 05:44:21 INFO - mozversion application_version: 46.0a1 05:44:21 INFO - mozversion platform_buildid: 20160118030338 05:44:21 INFO - mozversion platform_changeset: 8cb42e7a16b42162c9930f37b9e1f820c2eb126b 05:44:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:44:21 INFO - mozversion platform_version: 46.0a1 05:44:21 INFO - using testdate: 1453124661 05:44:21 INFO - actual date: 1453124661 05:44:21 INFO - starting webserver on 'localhost:50553' 05:44:21 INFO - SUITE-START | Running 3 tests 05:44:21 INFO - TEST-START | dromaeo_css 05:44:21 INFO - operating with platform_type : linux_ 05:44:21 INFO - Initialising browser for dromaeo_css test... 05:44:21 INFO - TEST-INFO | started process 4487 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb0Nsjl/profile http://localhost:50553/getInfo.html) 05:44:25 INFO - PROCESS | 4487 | -- checkerboarding starts below -- 05:44:25 INFO - PROCESS | 4487 | RENDERTRACE 0.042588 rect red 0 0 1024 768 // viewport 05:44:25 INFO - PROCESS | 4487 | RENDERTRACE 9.94348 rect brown 0 0 1024 768 // page 05:44:25 INFO - PROCESS | 4487 | RENDERTRACE 9.96048 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 05:44:25 INFO - PROCESS | 4487 | Checkerboarded for 1 frames (16.0488 ms), 786432 peak, 10428 severity. 05:44:25 INFO - PROCESS | 4487 | 05:44:25 INFO - PROCESS | 4487 | (process:4573): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:44:26 INFO - PROCESS | 4487 | __metrics Screen width/height:1600/1200 05:44:26 INFO - PROCESS | 4487 | colorDepth:24 05:44:26 INFO - PROCESS | 4487 | Browser inner width/height: 1024/697 05:44:26 INFO - PROCESS | 4487 | __metrics 05:44:26 INFO - PROCESS | 4487 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:44:26 INFO - PROCESS | 4487 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:44:27 INFO - TEST-INFO | 4487: exit 0 05:44:27 INFO - Browser initialized. 05:44:27 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:27 INFO - TEST-INFO | started process 4622 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb0Nsjl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:27 INFO - PROCESS | 4622 | -- checkerboarding starts below -- 05:44:27 INFO - PROCESS | 4622 | RENDERTRACE 0.040034 rect red 0 0 10 10 // viewport 05:44:27 INFO - PROCESS | 4622 | RENDERTRACE 18.3278 rect brown 0 0 10 10 // page 05:44:27 INFO - PROCESS | 4622 | RENDERTRACE 18.3618 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 05:44:27 INFO - PROCESS | 4622 | Checkerboarded for 1 frames (20.9092 ms), 100 peak, 1 severity. 05:44:28 INFO - PROCESS | 4622 | 05:44:28 INFO - PROCESS | 4622 | (process:4680): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:44:38 INFO - PROCESS | 4622 | RSS: Main: 150077440 05:44:38 INFO - PROCESS | 4622 | 05:45:28 INFO - PROCESS | 4622 | 1453124728562 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:47:37 INFO - PROCESS | 4622 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50553/tests/dromaeo/cssquery-ext.html) 05:47:38 INFO - PROCESS | 4622 | RSS: Main: 156852224 05:47:38 INFO - PROCESS | 4622 | 05:50:41 INFO - PROCESS | 4622 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-ext.html (next: http://localhost:50553/tests/dromaeo/cssquery-jquery.html) 05:50:41 INFO - PROCESS | 4622 | RSS: Main: 152010752 05:50:41 INFO - PROCESS | 4622 | 05:53:43 INFO - PROCESS | 4622 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50553/tests/dromaeo/cssquery-mootools.html) 05:53:43 INFO - PROCESS | 4622 | RSS: Main: 151293952 05:53:43 INFO - PROCESS | 4622 | 05:56:45 INFO - PROCESS | 4622 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50553/tests/dromaeo/cssquery-prototype.html) 05:56:46 INFO - PROCESS | 4622 | RSS: Main: 150204416 05:56:46 INFO - PROCESS | 4622 | 05:59:48 INFO - PROCESS | 4622 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50553/tests/dromaeo/cssquery-yui.html) 05:59:49 INFO - PROCESS | 4622 | RSS: Main: 151425024 05:59:49 INFO - PROCESS | 4622 | 06:02:51 INFO - PROCESS | 4622 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-yui.html (next: http://localhost:50553/tests/dromaeo/cssquery-dojo.html) 06:02:51 INFO - PROCESS | 4622 | RSS: Main: 153128960 06:02:51 INFO - PROCESS | 4622 | 06:02:51 INFO - PROCESS | 4622 | __start_tp_report 06:02:51 INFO - PROCESS | 4622 | _x_x_mozilla_page_load 06:02:51 INFO - PROCESS | 4622 | _x_x_mozilla_page_load_details 06:02:51 INFO - PROCESS | 4622 | |i|pagename|runs| 06:02:51 INFO - PROCESS | 4622 | |0;dojo.html;3189.3780712761013;3243.8540265688043;3254.0400581828358;3279.983600081999;3294.077658255689;5169.767360468779;5376.7311634418265;5378.408375078739;5382.569394448445;5388;5266.683998960065;5356;5387.0841956867325;5406.459354064592;5532.806351777688;4888.902221955567;4891.902161956758;4914.631402644798;4977.850664480072;4979.825706100287;5004.574611158056;5010.997800439908;5028.120078986181;5045.318881950926;5047.9747601262125;4786.89901322696;4875.34182885313;4904.166291730415;4906.067847109073;4995.825146119869;4971.801127954877;4977.104121258172;4982.551570358685;4988.127077761377;5037.5214354636255;4928.186849169882;4949.604031677457;4968.329275547827;4970.15507363749;4972.303877457159;5139.177731562932;5165.896682066337;5173.042987047371;5205.9219111713355;5239.79040838366;5781.595288329819;5782.306123265235;5787.1608616750755;5787.594868359217;5793.449622285876;5674.858128546778;5831.387704291031;5831.650100993911;5833.241678581757;5834.2998840139035;5342.225377320306;5459.672419654833;5499.560035197174;5516.365617953987;5552.91670624941;5903.35063143054;5909;5937.2578427696535;5944.524438044946;5946.375630558729;5495.890082198333;5603.047481928082;5708.971455142698;5722.9984752668115;5737.8565535861935;5725.198472213893;5738.426157384311;5802.564807639444;5812.505936995402;5849.590528663038;5668.801591944262;5687.317521897398;5703.201551782754;5706.543476521868;5709.0865461525955;5544.390117087117;5667.1782591524;5671.347795003545;5752.683602401824;5835.095560188178;4307.655387568987;4311.525732169459;4312.784360782011;4316.460442444694;4341.218580655513;3862.633049860259;3863.1114843586133;3865.96134038656;3905.7851818150275;3910.4720862683175;5252.1596544552685;5267;5323.414424413311;5403.945960540423;5408;5839;5875.9118613220835;5890.204822348928;5897.67562784051;5901.911471327933;5401.378841433207;5432.891342173213;5440.537554307928;5447.509724124848;5468.7539060742365;4834.444038935497;4851.951480485221;4933.703977761345;4956.752162391866;4960.404751429852;6009.098635204754;6014.488768454643;6017.729202185912;6042.456178943916;6053.909191362133;5870.706464676835;5876.08920617305;5882.764689412375;5885.234919460443;5909.438603332676;5753.280839895013;5809.302883653989;5831;5851.61964472308;5862.853428664317;5697.800576979786;5722.484976352148;5837.474627283395;5845.561582881216;5906.202662640489;5828.504577110993;5836.270466191726;5845.795397161079;5854.853628659318;5862.062070068769;5436;5555.111182210827;5682.545396368363;5682.659040457585;5694.088945768657;5694.202811606296;5721.456461636138;5749.913751293818;5776.191333213437;5783.074708046693;5431.6740995540395;5523.061079616395;5569.164625306236;5572.972135139298;5588.497035266845;5595.944040559542;5653.9822831889005;5667.971660141673;5672.234248376416;5674.233978413026;5624.35319938196;5671.971640141773;5681;5686.545076393796;5734.569907257056 06:02:51 INFO - PROCESS | 4622 | |1;ext.html;534.358769476628;540.8053100883682;541.3503795445466;558.5308340993564;564.497597138547;36248.63751362485;36462.81768591156;36481;36534.269314613695;36671.08322291944;39247;40039.799801000954;40064.59935400645;40118.39822402666;40294.39558406626;8545.957270213656;8623.137686231357;8698.043215246318;8708.21626053655;8716.869246961302;8514.531700756455;8621.224089831914;8648.091950345217;8796.648134074629;8804.075572064938;8752.431091979033;8766.60550275239;8827.205551500363;8833;8860.24687901526;8735.475871447701;8743.387962842604;8828.073052329477;8867.955660221689;8876.068012858686;8593.097724738938;8790.120987901222;8816.382853200279;8847.73456796297;8856.070112638208;39985.80007099975;40553.391699124535;40629.39055914163;40638.187236255406;40879.38680919789;3396.609389920166;3406.1654894550993;3451;3509.6314886937016;3629.6551827576336;28565.14304570866;29209.85395073011;29390.706092939225;29603.555946660817;29663.25841853949;3882.6311500407414;3923.3722604383447;3923.7645741255333;3924.7056470764805;3941.8029098544957;203015;206565;206740;206754;207471.96264018735;56828.431715682316;60645.39354606398;62087.37912620816;62297.68851155806;65243;62300.37699623036;62490.687546561974;62622.37377626257;62765.68617156885;62810.685946569974;14844;14863.851361486246;14998.400063997537;15061;15146.469873554373;11265.04247138986;11316.886831131584;11355.432228388547;11367.772644547229;11410.42947852604;20973.580528389346;21216.469588260108;21406.357809265748;22116.447088822588;22210.44473888166;8516.914830851736;8691.261242794308;8733.825323493495;8808.163224493663;8813.559322034002;986.7335819328741;1051.279873286801;1063.4098075568133;1073.8040706754705;1080.065743132185;28685.85657071743;30636.69363306383;31547;31578.842105789325;32049;1031.489412740683;1035.9430231337199;1054.593981317183;1055.9155267578576;1064.80649861286;14910.776338354934;15138.394464221528;15151.545453636409;15269.9236503819;15411;371303;374012;374157;374641;376098;52810.73594632002;53062.73468632632;53529.464705352446;53598.7320063405;53744.731276343366;1357.178906761415;1374.8625137486372;1391.7703578909366;1393.4078016843005;1398.1611033380093;28247.858760706065;28779.27324360545;29109.854450728457;29233.123006309845;29573.852130739207;45838.77080614575;46047.76976115098;46391;46421;46442.30336545022;292512;292820;294876;295497;296140;31996;44041.559584403745;44169;45045.32432013457;45083.77458112688;39856.402153968294;40100.799496002335;42078;42420.151596968506;43056.56943430651;36077.81961090178;36380.81809590935;37053.44419833651;37532.437013445364;37926;36025.63974360223;36589.26821463609;37059.25881482409;37091.25817483689;37312.626873730915;32945.34109317848;33503.83248083744;33528.49707254442;33786.66213337934;33930.151746206546;30658.233544161576;32786.83606582047;33166.834165829016;33227.50158747669;33662.663373365955;24712.50574988454;25037.624435633115;25299.114530992065;25400.74599253984;25580.616290755283 06:02:51 INFO - PROCESS | 4622 | |2;jquery.html;361.71243861130404;365.3879751416377;365.9041171690786;368.1073397012245;372.60689972079444;15766.763498547516;16086.436974705888;16848.578785530368;17117.657646847056;17762.111894405294;15132.697346053072;15319.77020344693;15582.142982135978;15603.219839008061;16016.75974860378;4873.122837889187;5065.341505604285;5067.949320506785;5075.9492405076035;5078.695278283315;4078.225137223933;4877.268409738532;4958.876028099308;4979.30289759434;4995.400551933773;4986.401631804189;5024.246363045536;5430.185472179165;5611.523020543259;5656.066748986413;5305.920411193835;5385.272988146589;5477.780888764464;5631.493165615094;5658.0381335172915;5132.794688212467;5163.044836705221;5168.9741551292;5181.455947125535;5209.348831396075;14659.926700366537;19434.80565194344;19984;20374.592508149755;20439.284625038053;2004.959900801976;2019.1115908999993;2076.0761461149796;2091.006771783406;2232.017912118679;9310.906890931072;9521.811661522173;9553.426794392359;10551.419671918042;12950.87049129506;1699.6005938604542;1705.505403433003;1745.677049745801;1769.1684908093175;1877.1271358818078;40637;52435.95128097455;53213.733931330484;55283;55375.169372459444;9915.157211636948;9950.701478955643;10050.949745251228;10061.4466204358;10333.896661033294;12782.744345113046;12837.358132093545;12899.93550032244;12905.741885162244;12936.15914965543;7402.629868506553;7409.555426674309;7427.108746950293;7462.253774622603;7510.136334321623;7093.858122837514;7148.320909513588;7168.319009694071;7169.4981351304905;7184.1019872515935;4135.545090040093;4257.467816522934;4446.4886538047895;4456.888577785517;4462.642988560908;1781.8841775284566;1837.4487653703836;1871.4759867237196;1885.9717104243448;1887.9433616991512;429.9656027517791;434.0559283558248;862.5945805471418;910.1080940678172;999.222162388561;9654.27592930533;10312.690619281433;10324.174066074696;10390.220733445021;10398.844017339747;453.9182947069493;454.9112922979987;457.44420529057356;467.59319392129066;472.3458010655199;5757.683327417032;5831.241938547962;9403.717888463358;10065;10088.192944564416;500418;505893;506304;536223;556519;70347.29652703408;71773.64113179401;72826;73780;74108.2589174112;1123.6404350607727;1142.1890457775073;1151.37825574189;1151.6429906728774;1155.1278784517635;15089.47186848455;15129.39482420691;15179.241037948279;15252.23738813077;15513.45702900393;32370.83814580912;32460.51309230316;33152.50271245981;33480;33856;42774;44600.10799784051;45279.32081018853;45619.543804562854;46479;7405.629718513945;7525.924740752742;7579.469437139347;7593.620318984139;7636.236376362319;10326.328788628714;10462.424566648908;11050.944745276222;11514.36670983104;11524;9546.99026408896;9677.419354838778;9708.514574271117;9779.511024448606;9897.901020989986;9820.4107753535;10144.644937427154;10217.131543818561;10218.54016569271;10303.587856485656;7022.40309573692;10139.239557033105;10279.537420815932;10535.683929482127;10613.893861061599;9456.858147127936;9695.175910047725;9967.900320996987;10280.537375817956;10372.481375931324;10394.856565777909;10420.739481513023;10564.261603585881;10646.8935310649;10740.624078157227 06:02:51 INFO - PROCESS | 4622 | |3;mootools.html;1428.492885025816;1480.851914808519;1644.26830060623;1787.7675902132721;1815.2376002079125;7902.802429939255;7928.8810667840025;8043.91956080439;8155.836883262346;8173.5504547249875;8203.507789532618;8268.958655206716;8307.91692083079;8342.74971750847;8349.791255218623;2322.3033090072954;2341.613633750429;2343.613303804879;2355.316958082154;2357.422431504275;2381.1903952656094;2415.516896620683;2463.2117722328862;2467.592847180213;2469.555480013597;2226.25420484138;2238.630625946717;2255.12050300383;2393.8324317297797;2470.950580988379;2299.1493147535352;2300.424893776556;2315.4211447138214;2323.1636610820174;2324.0936034946385;2375.5723969685623;2406.9890645928576;2407.65089062085;2408;2408.337707130536;8154.306883914815;8154.347652187811;8218.547979861105;8243.422960392774;8296.336293096538;4989.401271847365;5064.5441910228255;5073.162928116856;5089.338386009832;5092.10888094582;3192.393445245396;3197.2006998250436;3295;3323.9169020774675;3327.1515763480156;1010.1918465227861;1014.9514351195021;1035.0891215730185;1065.4725910674188;1078.946052697362;11199.832002519886;11343;11426.314421134759;11453.198276120675;11533.653990380302;4373.956260437419;4424.778761061998;4455.309427038749;4466.531014243523;4528.592426681548;9153.679621213225;9170.724878253663;9199.724008279762;9216.861747073799;9236.445813251226;4947.950520494821;4970.627202959792;4985.675931064469;4987.476314986947;4987.850364489072;4507.301368287855;4514.977425112919;4522.751248681354;4529.09418116378;4561.612262957619;3568.697425439696;3690.28039532294;3699.9445008324897;3703.7407381483035;3729.589745128034;1132.8980391764617;1134.9716257093473;1136.3125309187988;1140.8688000879838;1161.9709507262387;1098.8406681031365;1100.5542755184003;1134.489479734123;1286.9034822388357;1382.3641125082374;7447.962760186273;7501.699932002768;7511.9624401877645;7541.396688264926;7583.05211848519;1119.8096323625002;1129.2321221569412;1140.3670962615663;1146.3981409759776;1149.218531398657;5906.8818623627285;5924.229850119543;5928;5934.881302374015;5980.222571065734;9523.714288571355;9693.903060969442;9698.418094914186;9846.852297215548;9874.654387096418;9540.809183816285;9579.13787759091;9584.233261339075;9598.232141428669;9693;7326;7716.0354955631665;7750.341220996165;7750.728724494728;7780.988471498669;7543.7736867894055;7575.810604734926;7720.420968427278;7771.1840256774485;7816.452848300564;8820.735377938672;8986.59560319774;9019;9025.729228123168;9075.092490750872;9103.863442048241;9178.632854685738;9228.261739060994;9284.675036373694;9550.665726699532;7301.452391070585;7378.11462624467;7413.518121322312;7437.442191835742;7443.478956473212;7716.498427602188;7787.338076263581;7819.609019548886;7856.960715196387;7879.172686868025;6679.398854103154;7397.519161254501;7428.628568571442;7457.440691948017;7674.654640541301;6964.338387853146;6994.300569942965;7069.363757261871;7098.3256590623805;7136.179339376038;7219.386352160125;7233.421326293778;7274.01800756891;7279.890801637874;7313.853722925618;6700.4639628830555;6767.89848152288;6804.319568043156;6804.4216241620015;6811.829704257433;6650.068990341259;6650.90023649636;6694.364035416627;6705.966470167813;6726.125603671491 06:02:51 INFO - PROCESS | 4622 | |4;prototype.html;338.27777694621983;340.57258141033;343.9914002149946;348.4668457260392;349.42345130534596;6358.745650173993;6363.395477429637;6428.742850285983;6449.774257900975;6544.280129185786;6315.621062736228;6321.905171422421;6326.968365158168;6354.7775827846035;6368.426841584256;4807.855764327058;4845.830395936143;4851.126797176506;4855.198892182786;4868.342773725555;4847.878803029917;4864.14877396456;4868.659193856432;4870.902581948359;4873.6832105913;4611.239145540982;4682.648801339896;4690.671652984292;4745.193317136095;4799.3520874682;4682;4703.106409782147;4703.3885594872445;4708.081924024799;4713.552212539803;4083.9387409188885;4103.938440923389;4107.732997355192;4131.752094874317;4137.91724165518;5984.521238300926;5997.7001149942325;6000.309964354112;6027.849303767397;6034.275886893601;5495.6153069285165;5516.724163791834;5562.415946325658;5571.526420254283;5583.134614134816;6665.200175978914;6681.899771503431;6701.296363881771;6708.329167083301;6721.966390168018;4580.9692819115435;4590.632749380042;4591.770411479446;4606.746628935407;4612.7924243409125;6916.135483064617;6960.65196740166;7038;7042.119735033121;7052.929470705279;4706.317583950308;4711.128441238382;4714.4106986626675;4717.858464246078;4724;4756.904861902743;4758.333833263346;4765.309030190603;4770.284457331428;4781.545753153445;5477.370102438271;5543.113101903676;5543.279373681396;5544.944550554443;5551.916721249185;6567.474602031826;6681.799546013627;6716.664166791641;6760.83097922546;6770.221424536143;1628.5928517870532;1650.4058538925976;1675.852041351678;1676.2875777794388;1677.1195122560753;1062.7236918401272;1097.6268068856468;1097.780443911221;1102.1953973599318;1105.850710154135;6218.067289906459;6223.159873417031;6230.7819226326865;6233.812985610439;6239.78160764371;6824.249332573413;6871.553349032297;6873.862522749517;6877.277885822016;6892.793216203522;6074.51403887688;6178.196834411588;6182.258129024546;6215.06773983897;6233.2208473940755;3714.7741245388956;3717.7955212463035;3723.069232691827;3732.5520937487677;3741.4948981887096;7086.716531338792;7106.324899134574;7106.680199391039;7125.42996560274;7131.358177764027;6830.077939478107;6979.790606281819;7003.124609423822;7012.719491220396;7024.2273349931465;7077.752278670325;7080.858382832417;7089.751858684921;7097.858042839114;7110.431165506747;6810.5913645181445;6859.794206173823;6866.965665171642;6868.210155832143;6876.071730316343;6565.540412171103;6659.367360100783;6682.766103186365;6704.899426508704;6774.356436138559;6944.826379340557;6961.443084553122;6967.442604591722;6984.092068031124;7122.786316410516;4709.788059537261;4724.362211101595;4726.787294571821;4730.36140121093;4736.550027747358;6647.368499992493;6671.699773510107;6885.070515480346;6888.311168883071;6893.724251029903;6718.395344419026;6878.759243426456;6892.310768923067;6895.4138898194215;6895.724171033103;6804.659767011729;6815.352541508549;6819;6819.795406137824;6829.965850170717;6532.281449040697;6645.269020407848;6651.301613330531;6686.7993960181275;6692.297308782702;6779.694913728796;6852.760153394607;6857.725690972505;6866.107406037183;6871.828204294932;6661.933380666132;6678.866422671616;6680.732770689118;6684.732610695518;6686.498512611476 06:02:51 INFO - PROCESS | 4622 | |5;yui.html;787.2560430393279;803.7789607857842;813.5078277642028;843.6288033265363;850.5874650794364;13400.1959882407;13528.864711352884;13539.864601353984;13611.727765444697;13615.183089014667;12844.807327890088;12875.420606072727;12890.677733056678;12965.74068518629;12986.675333116676;784.7096574267515;801.1267718187174;819.6557445872747;823.3989187892842;824.6783754335814;809.8015986083388;813.7721437997341;817.3869597801648;818.100089901107;820.6471217376555;859.2824991132412;860.0968982568278;861.7242482405633;867.0635713429481;867.8264347130568;854.598338780772;863.3481721300441;863.5164307987548;864.9308055355588;865.3553102938288;626.573929727785;627.0093252660785;632.4940047961612;634.7651368993502;636.312782195228;14263.85736142646;14391.496297629637;14393.208373539452;14408.279586020763;14408.639784005483;12790;13071.477140914352;13124.6718832029;13205.669858253525;13269.469221231138;10107.393556386567;10284;10395.84406233907;10950.945245273722;11098.667039988732;3516.982415087908;3586.946195807065;3618.3848745713294;3671.430928206132;3700.2229531798353;52025;52338.21492677613;52544.47455525434;52671.999999999614;53132.46867531314;9299.53502324881;9362.955566650026;9388.436693798394;9689.757756056015;9829.361091529028;18162.364317249096;18198;18238.27046918135;18293.63412731738;18313.3590324338;7244.348008679139;7313.195548489662;7406.370458511087;7435.925640743631;7559.811004724816;4217.34631132175;4230.1539692061715;4258.361245813153;4280;4297.505786834491;3188.091393952712;3197.168736128623;3207.3905957867933;3212.4538828399227;3228.5480032795426;584.1383958661027;609.5489337889929;609.7256234694405;609.7682880505469;613.1844646619985;515.487090345109;583.5914859598298;593.6052525070779;600.3936024615083;611.7491828350355;7872.488288261245;8070.9192908071345;8284.50292982411;8308.584570771438;8664.91335086641;632.4718859752066;636.1952130554852;644.6776611694153;647.5984889368527;685.4379408884766;3848.9037774055314;3871.5160604924386;3950.6444420001762;3969.563348031714;3984.7031782515633;55739.72130139404;57307;57418.13872791911;58460.707696462094;58836.11745823816;44957.55042449533;45493.77253113713;45706.54293457089;45827.54172458233;45977.540224597324;46074.30888536674;46121.769391152826;46674.76662616665;47473.762631186626;50364.20811606565;8340.29107525867;8399.832003360021;8430.199131082783;8640;9116.498592577473;34937.65062349445;35037.82481087578;35158;36034;36280.81859590685;44784.77607611941;45111.54888451073;45652.315215272465;45860.31209531926;46315.768421159024;10444.843327350247;10838.349699018085;10908.290961087503;10958.506867190836;11214.66356009321;10613.840792387966;10993.615223467461;11842.822357664814;12229.205101668364;12356;11139.944300278446;11140.554377825121;11241.66275011751;11305.095592352427;11598.594049208576;11396.430178490877;11639.359835208807;11925;11997.100217483548;12024.639260822189;10807.783844322912;11296.887031129583;11344.376059316817;11468.483918223867;12085.818712719492;9015.864762028443;9208.714627272326;9240.907590924273;9245.537723113952;9333.393329433566;8826.293896488394;9310.906890931004;9429.858552121861;10091.596336146471;10112.848307275544 06:02:51 INFO - PROCESS | 4622 | __end_tp_report 06:02:51 INFO - PROCESS | 4622 | __start_cc_report 06:02:51 INFO - PROCESS | 4622 | _x_x_mozilla_cycle_collect,317 06:02:51 INFO - PROCESS | 4622 | __end_cc_report 06:02:51 INFO - PROCESS | 4622 | __startTimestamp1453125771918__endTimestamp 06:02:51 INFO - PROCESS | 4622 | 06:02:51 INFO - PROCESS | 4622 | ------- Summary: start ------- 06:02:51 INFO - PROCESS | 4622 | Number of tests: 6 06:02:51 INFO - PROCESS | 4622 | 06:02:51 INFO - PROCESS | 4622 | [#0] dojo.html Cycles:165 Average:5368.13 Median:5572.97 stddev:607.98 (10.9%) stddev-sans-first:585.32 06:02:51 INFO - PROCESS | 4622 | Values: 3189.4 3243.9 3254.0 3280.0 3294.1 5169.8 5376.7 5378.4 5382.6 5388.0 5266.7 5356.0 5387.1 5406.5 5532.8 4888.9 4891.9 4914.6 4977.9 4979.8 5004.6 5011.0 5028.1 5045.3 5048.0 4786.9 4875.3 4904.2 4906.1 4995.8 4971.8 4977.1 4982.6 4988.1 5037.5 4928.2 4949.6 4968.3 4970.2 4972.3 5139.2 5165.9 5173.0 5205.9 5239.8 5781.6 5782.3 5787.2 5787.6 5793.4 5674.9 5831.4 5831.7 5833.2 5834.3 5342.2 5459.7 5499.6 5516.4 5552.9 5903.4 5909.0 5937.3 5944.5 5946.4 5495.9 5603.0 5709.0 5723.0 5737.9 5725.2 5738.4 5802.6 5812.5 5849.6 5668.8 5687.3 5703.2 5706.5 5709.1 5544.4 5667.2 5671.3 5752.7 5835.1 4307.7 4311.5 4312.8 4316.5 4341.2 3862.6 3863.1 3866.0 3905.8 3910.5 5252.2 5267.0 5323.4 5403.9 5408.0 5839.0 5875.9 5890.2 5897.7 5901.9 5401.4 5432.9 5440.5 5447.5 5468.8 4834.4 4852.0 4933.7 4956.8 4960.4 6009.1 6014.5 6017.7 6042.5 6053.9 5870.7 5876.1 5882.8 5885.2 5909.4 5753.3 5809.3 5831.0 5851.6 5862.9 5697.8 5722.5 5837.5 5845.6 5906.2 5828.5 5836.3 5845.8 5854.9 5862.1 5436.0 5555.1 5682.5 5682.7 5694.1 5694.2 5721.5 5749.9 5776.2 5783.1 5431.7 5523.1 5569.2 5573.0 5588.5 5595.9 5654.0 5668.0 5672.2 5674.2 5624.4 5672.0 5681.0 5686.5 5734.6 06:02:51 INFO - PROCESS | 4622 | 06:02:51 INFO - PROCESS | 4622 | [#1] ext.html Cycles:180 Average:46667.98 Median:37075.26 stddev:78599.13 (212.0%) stddev-sans-first:78743.30 06:02:51 INFO - PROCESS | 4622 | Values: 534.4 540.8 541.4 558.5 564.5 36248.6 36462.8 36481.0 36534.3 36671.1 39247.0 40039.8 40064.6 40118.4 40294.4 8546.0 8623.1 8698.0 8708.2 8716.9 8514.5 8621.2 8648.1 8796.6 8804.1 8752.4 8766.6 8827.2 8833.0 8860.2 8735.5 8743.4 8828.1 8868.0 8876.1 8593.1 8790.1 8816.4 8847.7 8856.1 39985.8 40553.4 40629.4 40638.2 40879.4 3396.6 3406.2 3451.0 3509.6 3629.7 28565.1 29209.9 29390.7 29603.6 29663.3 3882.6 3923.4 3923.8 3924.7 3941.8 203015.0 206565.0 206740.0 206754.0 207472.0 56828.4 60645.4 62087.4 62297.7 65243.0 62300.4 62490.7 62622.4 62765.7 62810.7 14844.0 14863.9 14998.4 15061.0 15146.5 11265.0 11316.9 11355.4 11367.8 11410.4 20973.6 21216.5 21406.4 22116.4 22210.4 8516.9 8691.3 8733.8 8808.2 8813.6 986.7 1051.3 1063.4 1073.8 1080.1 28685.9 30636.7 31547.0 31578.8 32049.0 1031.5 1035.9 1054.6 1055.9 1064.8 14910.8 15138.4 15151.5 15269.9 15411.0 371303.0 374012.0 374157.0 374641.0 376098.0 52810.7 53062.7 53529.5 53598.7 53744.7 1357.2 1374.9 1391.8 1393.4 1398.2 28247.9 28779.3 29109.9 29233.1 29573.9 45838.8 46047.8 46391.0 46421.0 46442.3 292512.0 292820.0 294876.0 295497.0 296140.0 31996.0 44041.6 44169.0 45045.3 45083.8 39856.4 40100.8 42078.0 42420.2 43056.6 36077.8 36380.8 37053.4 37532.4 37926.0 36025.6 36589.3 37059.3 37091.3 37312.6 32945.3 33503.8 33528.5 33786.7 33930.2 30658.2 32786.8 33166.8 33227.5 33662.7 24712.5 25037.6 25299.1 25400.7 25580.6 06:02:51 INFO - PROCESS | 4622 | 06:02:51 INFO - PROCESS | 4622 | [#2] jquery.html Cycles:180 Average:26750.82 Median:21601.98 stddev:85205.27 (394.4%) stddev-sans-first:85421.25 06:02:51 INFO - PROCESS | 4622 | Values: 361.7 365.4 365.9 368.1 372.6 15766.8 16086.4 16848.6 17117.7 17762.1 15132.7 15319.8 15582.1 15603.2 16016.8 4873.1 5065.3 5067.9 5075.9 5078.7 4078.2 4877.3 4958.9 4979.3 4995.4 4986.4 5024.2 5430.2 5611.5 5656.1 5305.9 5385.3 5477.8 5631.5 5658.0 5132.8 5163.0 5169.0 5181.5 5209.3 14659.9 19434.8 19984.0 20374.6 20439.3 2005.0 2019.1 2076.1 2091.0 2232.0 9310.9 9521.8 9553.4 10551.4 12950.9 1699.6 1705.5 1745.7 1769.2 1877.1 40637.0 52436.0 53213.7 55283.0 55375.2 9915.2 9950.7 10050.9 10061.4 10333.9 12782.7 12837.4 12899.9 12905.7 12936.2 7402.6 7409.6 7427.1 7462.3 7510.1 7093.9 7148.3 7168.3 7169.5 7184.1 4135.5 4257.5 4446.5 4456.9 4462.6 1781.9 1837.4 1871.5 1886.0 1887.9 430.0 434.1 862.6 910.1 999.2 9654.3 10312.7 10324.2 10390.2 10398.8 453.9 454.9 457.4 467.6 472.3 5757.7 5831.2 9403.7 10065.0 10088.2 500418.0 505893.0 506304.0 536223.0 556519.0 70347.3 71773.6 72826.0 73780.0 74108.3 1123.6 1142.2 1151.4 1151.6 1155.1 15089.5 15129.4 15179.2 15252.2 15513.5 32370.8 32460.5 33152.5 33480.0 33856.0 42774.0 44600.1 45279.3 45619.5 46479.0 7405.6 7525.9 7579.5 7593.6 7636.2 10326.3 10462.4 11050.9 11514.4 11524.0 9547.0 9677.4 9708.5 9779.5 9897.9 9820.4 10144.6 10217.1 10218.5 10303.6 7022.4 10139.2 10279.5 10535.7 10613.9 9456.9 9695.2 9967.9 10280.5 10372.5 10394.9 10420.7 10564.3 10646.9 10740.6 06:02:51 INFO - PROCESS | 4622 | 06:02:51 INFO - PROCESS | 4622 | [#3] mootools.html Cycles:180 Average:5715.53 Median:6650.48 stddev:2969.25 (44.6%) stddev-sans-first:2960.09 06:02:51 INFO - PROCESS | 4622 | Values: 1428.5 1480.9 1644.3 1787.8 1815.2 7902.8 7928.9 8043.9 8155.8 8173.6 8203.5 8269.0 8307.9 8342.7 8349.8 2322.3 2341.6 2343.6 2355.3 2357.4 2381.2 2415.5 2463.2 2467.6 2469.6 2226.3 2238.6 2255.1 2393.8 2471.0 2299.1 2300.4 2315.4 2323.2 2324.1 2375.6 2407.0 2407.7 2408.0 2408.3 8154.3 8154.3 8218.5 8243.4 8296.3 4989.4 5064.5 5073.2 5089.3 5092.1 3192.4 3197.2 3295.0 3323.9 3327.2 1010.2 1015.0 1035.1 1065.5 1078.9 11199.8 11343.0 11426.3 11453.2 11533.7 4374.0 4424.8 4455.3 4466.5 4528.6 9153.7 9170.7 9199.7 9216.9 9236.4 4948.0 4970.6 4985.7 4987.5 4987.9 4507.3 4515.0 4522.8 4529.1 4561.6 3568.7 3690.3 3699.9 3703.7 3729.6 1132.9 1135.0 1136.3 1140.9 1162.0 1098.8 1100.6 1134.5 1286.9 1382.4 7448.0 7501.7 7512.0 7541.4 7583.1 1119.8 1129.2 1140.4 1146.4 1149.2 5906.9 5924.2 5928.0 5934.9 5980.2 9523.7 9693.9 9698.4 9846.9 9874.7 9540.8 9579.1 9584.2 9598.2 9693.0 7326.0 7716.0 7750.3 7750.7 7781.0 7543.8 7575.8 7720.4 7771.2 7816.5 8820.7 8986.6 9019.0 9025.7 9075.1 9103.9 9178.6 9228.3 9284.7 9550.7 7301.5 7378.1 7413.5 7437.4 7443.5 7716.5 7787.3 7819.6 7857.0 7879.2 6679.4 7397.5 7428.6 7457.4 7674.7 6964.3 6994.3 7069.4 7098.3 7136.2 7219.4 7233.4 7274.0 7279.9 7313.9 6700.5 6767.9 6804.3 6804.4 6811.8 6650.1 6650.9 6694.4 6706.0 6726.1 06:02:51 INFO - PROCESS | 4622 | 06:02:51 INFO - PROCESS | 4622 | [#4] prototype.html Cycles:180 Average:5575.66 Median:6318.76 stddev:1693.39 (26.8%) stddev-sans-first:1651.88 06:02:51 INFO - PROCESS | 4622 | Values: 338.3 340.6 344.0 348.5 349.4 6358.7 6363.4 6428.7 6449.8 6544.3 6315.6 6321.9 6327.0 6354.8 6368.4 4807.9 4845.8 4851.1 4855.2 4868.3 4847.9 4864.1 4868.7 4870.9 4873.7 4611.2 4682.6 4690.7 4745.2 4799.4 4682.0 4703.1 4703.4 4708.1 4713.6 4083.9 4103.9 4107.7 4131.8 4137.9 5984.5 5997.7 6000.3 6027.8 6034.3 5495.6 5516.7 5562.4 5571.5 5583.1 6665.2 6681.9 6701.3 6708.3 6722.0 4581.0 4590.6 4591.8 4606.7 4612.8 6916.1 6960.7 7038.0 7042.1 7052.9 4706.3 4711.1 4714.4 4717.9 4724.0 4756.9 4758.3 4765.3 4770.3 4781.5 5477.4 5543.1 5543.3 5544.9 5551.9 6567.5 6681.8 6716.7 6760.8 6770.2 1628.6 1650.4 1675.9 1676.3 1677.1 1062.7 1097.6 1097.8 1102.2 1105.9 6218.1 6223.2 6230.8 6233.8 6239.8 6824.2 6871.6 6873.9 6877.3 6892.8 6074.5 6178.2 6182.3 6215.1 6233.2 3714.8 3717.8 3723.1 3732.6 3741.5 7086.7 7106.3 7106.7 7125.4 7131.4 6830.1 6979.8 7003.1 7012.7 7024.2 7077.8 7080.9 7089.8 7097.9 7110.4 6810.6 6859.8 6867.0 6868.2 6876.1 6565.5 6659.4 6682.8 6704.9 6774.4 6944.8 6961.4 6967.4 6984.1 7122.8 4709.8 4724.4 4726.8 4730.4 4736.6 6647.4 6671.7 6885.1 6888.3 6893.7 6718.4 6878.8 6892.3 6895.4 6895.7 6804.7 6815.4 6819.0 6819.8 6830.0 6532.3 6645.3 6651.3 6686.8 6692.3 6779.7 6852.8 6857.7 6866.1 6871.8 6661.9 6678.9 6680.7 6684.7 6686.5 06:02:51 INFO - PROCESS | 4622 | 06:02:51 INFO - PROCESS | 4622 | [#5] yui.html Cycles:180 Average:13830.35 Median:46025.92 stddev:16024.95 (34.8%) stddev-sans-first:16039.97 06:02:51 INFO - PROCESS | 4622 | Values: 787.3 803.8 813.5 843.6 850.6 13400.2 13528.9 13539.9 13611.7 13615.2 12844.8 12875.4 12890.7 12965.7 12986.7 784.7 801.1 819.7 823.4 824.7 809.8 813.8 817.4 818.1 820.6 859.3 860.1 861.7 867.1 867.8 854.6 863.3 863.5 864.9 865.4 626.6 627.0 632.5 634.8 636.3 14263.9 14391.5 14393.2 14408.3 14408.6 12790.0 13071.5 13124.7 13205.7 13269.5 10107.4 10284.0 10395.8 10950.9 11098.7 3517.0 3586.9 3618.4 3671.4 3700.2 52025.0 52338.2 52544.5 52672.0 53132.5 9299.5 9363.0 9388.4 9689.8 9829.4 18162.4 18198.0 18238.3 18293.6 18313.4 7244.3 7313.2 7406.4 7435.9 7559.8 4217.3 4230.2 4258.4 4280.0 4297.5 3188.1 3197.2 3207.4 3212.5 3228.5 584.1 609.5 609.7 609.8 613.2 515.5 583.6 593.6 600.4 611.7 7872.5 8070.9 8284.5 8308.6 8664.9 632.5 636.2 644.7 647.6 685.4 3848.9 3871.5 3950.6 3969.6 3984.7 55739.7 57307.0 57418.1 58460.7 58836.1 44957.6 45493.8 45706.5 45827.5 45977.5 46074.3 46121.8 46674.8 47473.8 50364.2 8340.3 8399.8 8430.2 8640.0 9116.5 34937.7 35037.8 35158.0 36034.0 36280.8 44784.8 45111.5 45652.3 45860.3 46315.8 10444.8 10838.3 10908.3 10958.5 11214.7 10613.8 10993.6 11842.8 12229.2 12356.0 11139.9 11140.6 11241.7 11305.1 11598.6 11396.4 11639.4 11925.0 11997.1 12024.6 10807.8 11296.9 11344.4 11468.5 12085.8 9015.9 9208.7 9240.9 9245.5 9333.4 8826.3 9310.9 9429.9 10091.6 10112.8 06:02:51 INFO - PROCESS | 4622 | -------- Summary: end -------- 06:02:51 INFO - PROCESS | 4622 | 06:02:52 INFO - TEST-INFO | 4622: exit 0 06:02:52 INFO - TEST-OK | dromaeo_css | took 1111153ms 06:02:52 INFO - TEST-START | kraken 06:02:52 INFO - operating with platform_type : linux_ 06:02:52 INFO - Initialising browser for kraken test... 06:02:52 INFO - TEST-INFO | started process 4861 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplrSQiP/profile http://localhost:50553/getInfo.html) 06:02:56 INFO - PROCESS | 4861 | 06:02:56 INFO - PROCESS | 4861 | (process:4934): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:02:57 INFO - PROCESS | 4861 | __metrics Screen width/height:1600/1200 06:02:57 INFO - PROCESS | 4861 | colorDepth:24 06:02:57 INFO - PROCESS | 4861 | Browser inner width/height: 1024/697 06:02:57 INFO - PROCESS | 4861 | __metrics 06:02:57 INFO - PROCESS | 4861 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:02:58 INFO - TEST-INFO | 4861: exit 0 06:02:58 INFO - Browser initialized. 06:02:58 INFO - Running cycle 1/1 for kraken test... 06:02:58 INFO - TEST-INFO | started process 4983 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplrSQiP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:58 INFO - PROCESS | 4983 | -- checkerboarding starts below -- 06:02:58 INFO - PROCESS | 4983 | RENDERTRACE 0.057363 rect red 0 0 10 10 // viewport 06:02:58 INFO - PROCESS | 4983 | RENDERTRACE 34.8654 rect brown 0 0 10 10 // page 06:02:58 INFO - PROCESS | 4983 | RENDERTRACE 34.8887 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 06:02:58 INFO - PROCESS | 4983 | Checkerboarded for 1 frames (50.3729 ms), 100 peak, 1 severity. 06:02:59 INFO - PROCESS | 4983 | 06:02:59 INFO - PROCESS | 4983 | (process:5044): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:03:09 INFO - PROCESS | 4983 | RSS: Main: 150605824 06:03:09 INFO - PROCESS | 4983 | 06:03:12 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50553/tests/kraken/driver.html?testName=audio-beat-detection) 06:03:12 INFO - PROCESS | 4983 | RSS: Main: 151031808 06:03:12 INFO - PROCESS | 4983 | 06:03:15 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50553/tests/kraken/driver.html?testName=audio-dft) 06:03:16 INFO - PROCESS | 4983 | RSS: Main: 154898432 06:03:16 INFO - PROCESS | 4983 | 06:03:19 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50553/tests/kraken/driver.html?testName=audio-fft) 06:03:19 INFO - PROCESS | 4983 | RSS: Main: 147927040 06:03:19 INFO - PROCESS | 4983 | 06:03:21 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50553/tests/kraken/driver.html?testName=audio-oscillator) 06:03:22 INFO - PROCESS | 4983 | RSS: Main: 148918272 06:03:22 INFO - PROCESS | 4983 | 06:03:24 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:25 INFO - PROCESS | 4983 | RSS: Main: 149061632 06:03:25 INFO - PROCESS | 4983 | 06:03:28 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50553/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:28 INFO - PROCESS | 4983 | RSS: Main: 149336064 06:03:28 INFO - PROCESS | 4983 | 06:03:32 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50553/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:32 INFO - PROCESS | 4983 | RSS: Main: 149315584 06:03:32 INFO - PROCESS | 4983 | 06:03:35 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50553/tests/kraken/driver.html?testName=json-parse-financial) 06:03:36 INFO - PROCESS | 4983 | RSS: Main: 149884928 06:03:36 INFO - PROCESS | 4983 | 06:03:37 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:38 INFO - PROCESS | 4983 | RSS: Main: 148099072 06:03:38 INFO - PROCESS | 4983 | 06:03:40 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:40 INFO - PROCESS | 4983 | RSS: Main: 149811200 06:03:40 INFO - PROCESS | 4983 | 06:03:42 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:43 INFO - PROCESS | 4983 | RSS: Main: 149917696 06:03:43 INFO - PROCESS | 4983 | 06:03:45 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:46 INFO - PROCESS | 4983 | RSS: Main: 150437888 06:03:46 INFO - PROCESS | 4983 | 06:03:48 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:49 INFO - PROCESS | 4983 | RSS: Main: 149610496 06:03:49 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50553/tests/kraken/driver.html?testName=ai-astar) 06:03:51 INFO - PROCESS | 4983 | RSS: Main: 149770240 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | __start_tp_report 06:03:51 INFO - PROCESS | 4983 | _x_x_mozilla_page_load 06:03:51 INFO - PROCESS | 4983 | _x_x_mozilla_page_load_details 06:03:51 INFO - PROCESS | 4983 | |i|pagename|runs| 06:03:51 INFO - PROCESS | 4983 | |0;ai-astar;111;108;110;111;109;121;111;110;111;110 06:03:51 INFO - PROCESS | 4983 | |1;audio-beat-detection;150;128;145;161;128;152;153;129;167;123 06:03:51 INFO - PROCESS | 4983 | |2;audio-dft;163;163;164;162;161;161;160;166;167;160 06:03:51 INFO - PROCESS | 4983 | |3;audio-fft;71;72;72;75;73;71;131;72;74;79 06:03:51 INFO - PROCESS | 4983 | |4;audio-oscillator;95;96;138;97;95;97;147;95;97;133 06:03:51 INFO - PROCESS | 4983 | |5;imaging-gaussian-blur;110;109;112;110;111;110;109;109;110;110 06:03:51 INFO - PROCESS | 4983 | |6;imaging-darkroom;146;146;146;147;147;147;146;146;146;148 06:03:51 INFO - PROCESS | 4983 | |7;imaging-desaturate;96;96;97;96;96;97;96;97;97;96 06:03:51 INFO - PROCESS | 4983 | |8;json-parse-financial;60;63;60;57;60;59;61;58;67;57 06:03:51 INFO - PROCESS | 4983 | |9;json-stringify-tinderbox;69;70;68;69;70;69;69;70;69;70 06:03:51 INFO - PROCESS | 4983 | |10;stanford-crypto-aes;84;84;84;85;87;86;85;87;83;85 06:03:51 INFO - PROCESS | 4983 | |11;stanford-crypto-ccm;127;117;119;123;113;120;123;128;123;120 06:03:51 INFO - PROCESS | 4983 | |12;stanford-crypto-pbkdf2;143;145;144;164;156;138;149;150;151;149 06:03:51 INFO - PROCESS | 4983 | |13;stanford-crypto-sha256-iterative;70;67;69;71;68;69;71;69;70;70 06:03:51 INFO - PROCESS | 4983 | __end_tp_report 06:03:51 INFO - PROCESS | 4983 | __start_cc_report 06:03:51 INFO - PROCESS | 4983 | _x_x_mozilla_cycle_collect,767 06:03:51 INFO - PROCESS | 4983 | __end_cc_report 06:03:51 INFO - PROCESS | 4983 | __startTimestamp1453125831570__endTimestamp 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | ------- Summary: start ------- 06:03:51 INFO - PROCESS | 4983 | Number of tests: 14 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:3.58 (3.2%) stddev-sans-first:3.80 06:03:51 INFO - PROCESS | 4983 | Values: 111.0 108.0 110.0 111.0 109.0 121.0 111.0 110.0 111.0 110.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:151.00 stddev:15.55 (10.3%) stddev-sans-first:16.32 06:03:51 INFO - PROCESS | 4983 | Values: 150.0 128.0 145.0 161.0 128.0 152.0 153.0 129.0 167.0 123.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:2.41 (1.5%) stddev-sans-first:2.55 06:03:51 INFO - PROCESS | 4983 | Values: 163.0 163.0 164.0 162.0 161.0 161.0 160.0 166.0 167.0 160.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#3] audio-fft Cycles:10 Average:79.00 Median:72.50 stddev:18.43 (25.4%) stddev-sans-first:19.32 06:03:51 INFO - PROCESS | 4983 | Values: 71.0 72.0 72.0 75.0 73.0 71.0 131.0 72.0 74.0 79.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.50 stddev:21.21 (22.2%) stddev-sans-first:21.89 06:03:51 INFO - PROCESS | 4983 | Values: 95.0 96.0 138.0 97.0 95.0 97.0 147.0 95.0 97.0 133.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.94 (0.9%) stddev-sans-first:1.00 06:03:51 INFO - PROCESS | 4983 | Values: 110.0 109.0 112.0 110.0 111.0 110.0 109.0 109.0 110.0 110.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:03:51 INFO - PROCESS | 4983 | Values: 146.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 148.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:03:51 INFO - PROCESS | 4983 | Values: 96.0 96.0 97.0 96.0 96.0 97.0 96.0 97.0 97.0 96.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:3.01 (5.0%) stddev-sans-first:3.19 06:03:51 INFO - PROCESS | 4983 | Values: 60.0 63.0 60.0 57.0 60.0 59.0 61.0 58.0 67.0 57.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 06:03:51 INFO - PROCESS | 4983 | Values: 69.0 70.0 68.0 69.0 70.0 69.0 69.0 70.0 69.0 70.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:1.33 (1.6%) stddev-sans-first:1.36 06:03:51 INFO - PROCESS | 4983 | Values: 84.0 84.0 84.0 85.0 87.0 86.0 85.0 87.0 83.0 85.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:123.00 stddev:4.50 (3.7%) stddev-sans-first:4.27 06:03:51 INFO - PROCESS | 4983 | Values: 127.0 117.0 119.0 123.0 113.0 120.0 123.0 128.0 123.0 120.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:149.50 stddev:7.28 (4.9%) stddev-sans-first:7.40 06:03:51 INFO - PROCESS | 4983 | Values: 143.0 145.0 144.0 164.0 156.0 138.0 149.0 150.0 151.0 149.0 06:03:51 INFO - PROCESS | 4983 | 06:03:51 INFO - PROCESS | 4983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 06:03:51 INFO - PROCESS | 4983 | Values: 70.0 67.0 69.0 71.0 68.0 69.0 71.0 69.0 70.0 70.0 06:03:51 INFO - PROCESS | 4983 | -------- Summary: end -------- 06:03:51 INFO - PROCESS | 4983 | 06:03:52 INFO - TEST-INFO | 4983: exit 0 06:03:52 INFO - TEST-OK | kraken | took 60105ms 06:03:52 INFO - TEST-START | v8_7 06:03:52 INFO - operating with platform_type : linux_ 06:03:52 INFO - Initialising browser for v8_7 test... 06:03:52 INFO - TEST-INFO | started process 5272 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbGnePN/profile http://localhost:50553/getInfo.html) 06:03:56 INFO - PROCESS | 5272 | 06:03:56 INFO - PROCESS | 5272 | (process:5344): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:03:57 INFO - PROCESS | 5272 | __metrics Screen width/height:1600/1200 06:03:57 INFO - PROCESS | 5272 | colorDepth:24 06:03:57 INFO - PROCESS | 5272 | Browser inner width/height: 1024/697 06:03:57 INFO - PROCESS | 5272 | __metrics 06:03:57 INFO - PROCESS | 5272 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:03:58 INFO - TEST-INFO | 5272: exit 0 06:03:58 INFO - Browser initialized. 06:03:58 INFO - Running cycle 1/1 for v8_7 test... 06:03:58 INFO - TEST-INFO | started process 5393 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbGnePN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:59 INFO - PROCESS | 5393 | -- checkerboarding starts below -- 06:03:59 INFO - PROCESS | 5393 | RENDERTRACE 0.040324 rect red 0 0 10 10 // viewport 06:03:59 INFO - PROCESS | 5393 | RENDERTRACE 77.2446 rect brown 0 0 10 10 // page 06:03:59 INFO - PROCESS | 5393 | RENDERTRACE 77.2832 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 06:03:59 INFO - PROCESS | 5393 | Checkerboarded for 1 frames (83.6114 ms), 100 peak, 1 severity. 06:03:59 INFO - PROCESS | 5393 | 06:03:59 INFO - PROCESS | 5393 | (process:5453): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:04:10 INFO - PROCESS | 5393 | RSS: Main: 150097920 06:04:10 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | Cycle 1(1): loaded http://localhost:50553/tests/v8_7/run.html (next: http://localhost:50553/tests/v8_7/run.html) 06:04:32 INFO - PROCESS | 5393 | RSS: Main: 146423808 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | __start_tp_report 06:04:32 INFO - PROCESS | 5393 | _x_x_mozilla_page_load 06:04:32 INFO - PROCESS | 5393 | _x_x_mozilla_page_load_details 06:04:32 INFO - PROCESS | 5393 | |i|pagename|runs| 06:04:32 INFO - PROCESS | 5393 | |0;Richards;169.43409013893594 06:04:32 INFO - PROCESS | 5393 | |1;DeltaBlue;194.21246844047388 06:04:32 INFO - PROCESS | 5393 | |2;Encrypt;283.2058906825262 06:04:32 INFO - PROCESS | 5393 | |3;Decrypt;5263.1578947368425 06:04:32 INFO - PROCESS | 5393 | |4;RayTrace;1075.268817204301 06:04:32 INFO - PROCESS | 5393 | |5;Earley;725.1631617113851 06:04:32 INFO - PROCESS | 5393 | |6;Boyer;12382.716049382716 06:04:32 INFO - PROCESS | 5393 | |7;RegExp;41020 06:04:32 INFO - PROCESS | 5393 | |8;Splay;624.2197253433209 06:04:32 INFO - PROCESS | 5393 | |9;NavierStokes;4835.748792270531 06:04:32 INFO - PROCESS | 5393 | __end_tp_report 06:04:32 INFO - PROCESS | 5393 | __startTimestamp1453125872805__endTimestamp 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | ------- Summary: start ------- 06:04:32 INFO - PROCESS | 5393 | Number of tests: 10 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | [#0] Richards Cycles:1 Average:169.43 Median:169.43 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 5393 | Values: 169.4 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | [#1] DeltaBlue Cycles:1 Average:194.21 Median:194.21 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 5393 | Values: 194.2 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | [#2] Encrypt Cycles:1 Average:283.21 Median:283.21 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 5393 | Values: 283.2 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 5393 | Values: 5263.2 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 5393 | Values: 1075.3 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | [#5] Earley Cycles:1 Average:725.16 Median:725.16 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 5393 | Values: 725.2 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 5393 | Values: 12382.7 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | [#7] RegExp Cycles:1 Average:41020.00 Median:41020.00 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 5393 | Values: 41020.0 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | [#8] Splay Cycles:1 Average:624.22 Median:624.22 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 5393 | Values: 624.2 06:04:32 INFO - PROCESS | 5393 | 06:04:32 INFO - PROCESS | 5393 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 5393 | Values: 4835.7 06:04:32 INFO - PROCESS | 5393 | -------- Summary: end -------- 06:04:32 INFO - PROCESS | 5393 | 06:04:33 INFO - TEST-INFO | 5393: exit 0 06:04:33 INFO - TEST-OK | v8_7 | took 41087ms 06:04:33 INFO - SUITE-END | took 1212s 06:04:33 INFO - Completed test suite (00:20:12) 06:04:33 INFO - Working with test: dromaeo_css 06:04:33 INFO - Generating results file: dromaeo_css 06:04:33 INFO - Working with test: kraken 06:04:33 INFO - Generating results file: kraken 06:04:33 INFO - javascript benchmark 06:04:33 INFO - Working with test: v8_7 06:04:33 INFO - Generating results file: v8_7 06:04:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:04:33 INFO - process_Request line: dromaeo_css 6984.60 graph.html#tests=[[72,1,43]] 06:04:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:33 INFO - process_Request line: kraken 1512.50 graph.html#tests=[[232,1,43]] 06:04:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:34 INFO - process_Request line: v8_7 20104.05 graph.html#tests=[[230,1,43]] 06:04:34 INFO - RETURN: dromaeo_css: 6984.60 06:04:34 INFO - RETURN: kraken: 1512.50 06:04:34 INFO - RETURN: v8_7: 20104.05 06:04:34 INFO - javascript benchmark 06:04:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3189.3780712761013, 3243.8540265688043, 3254.0400581828358, 3279.983600081999, 3294.077658255689, 5169.767360468779, 5376.7311634418265, 5378.408375078739, 5382.569394448445, 5388.0, 5266.683998960065, 5356.0, 5387.0841956867325, 5406.459354064592, 5532.806351777688, 4888.902221955567, 4891.902161956758, 4914.631402644798, 4977.850664480072, 4979.825706100287, 5004.574611158056, 5010.997800439908, 5028.120078986181, 5045.318881950926, 5047.9747601262125, 4786.89901322696, 4875.34182885313, 4904.166291730415, 4906.067847109073, 4995.825146119869, 4971.801127954877, 4977.104121258172, 4982.551570358685, 4988.127077761377, 5037.5214354636255, 4928.186849169882, 4949.604031677457, 4968.329275547827, 4970.15507363749, 4972.303877457159, 5139.177731562932, 5165.896682066337, 5173.042987047371, 5205.9219111713355, 5239.79040838366, 5781.595288329819, 5782.306123265235, 5787.1608616750755, 5787.594868359217, 5793.449622285876, 5674.858128546778, 5831.387704291031, 5831.650100993911, 5833.241678581757, 5834.2998840139035, 5342.225377320306, 5459.672419654833, 5499.560035197174, 5516.365617953987, 5552.91670624941, 5903.35063143054, 5909.0, 5937.2578427696535, 5944.524438044946, 5946.375630558729, 5495.890082198333, 5603.047481928082, 5708.971455142698, 5722.9984752668115, 5737.8565535861935, 5725.198472213893, 5738.426157384311, 5802.564807639444, 5812.505936995402, 5849.590528663038, 5668.801591944262, 5687.317521897398, 5703.201551782754, 5706.543476521868, 5709.0865461525955, 5544.390117087117, 5667.1782591524, 5671.347795003545, 5752.683602401824, 5835.095560188178, 4307.655387568987, 4311.525732169459, 4312.784360782011, 4316.460442444694, 4341.218580655513, 3862.633049860259, 3863.1114843586133, 3865.96134038656, 3905.7851818150275, 3910.4720862683175, 5252.1596544552685, 5267.0, 5323.414424413311, 5403.945960540423, 5408.0, 5839.0, 5875.9118613220835, 5890.204822348928, 5897.67562784051, 5901.911471327933, 5401.378841433207, 5432.891342173213, 5440.537554307928, 5447.509724124848, 5468.7539060742365, 4834.444038935497, 4851.951480485221, 4933.703977761345, 4956.752162391866, 4960.404751429852, 6009.098635204754, 6014.488768454643, 6017.729202185912, 6042.456178943916, 6053.909191362133, 5870.706464676835, 5876.08920617305, 5882.764689412375, 5885.234919460443, 5909.438603332676, 5753.280839895013, 5809.302883653989, 5831.0, 5851.61964472308, 5862.853428664317, 5697.800576979786, 5722.484976352148, 5837.474627283395, 5845.561582881216, 5906.202662640489, 5828.504577110993, 5836.270466191726, 5845.795397161079, 5854.853628659318, 5862.062070068769, 5436.0, 5555.111182210827, 5682.545396368363, 5682.659040457585, 5694.088945768657, 5694.202811606296, 5721.456461636138, 5749.913751293818, 5776.191333213437, 5783.074708046693, 5431.6740995540395, 5523.061079616395, 5569.164625306236, 5572.972135139298, 5588.497035266845, 5595.944040559542, 5653.9822831889005, 5667.971660141673, 5672.234248376416, 5674.233978413026, 5624.35319938196, 5671.971640141773, 5681.0, 5686.545076393796, 5734.569907257056], "unit": "score", "name": "dojo.html", "value": 5327.923709284917}, {"lowerIsBetter": false, "replicates": [534.358769476628, 540.8053100883682, 541.3503795445466, 558.5308340993564, 564.497597138547, 36248.63751362485, 36462.81768591156, 36481.0, 36534.269314613695, 36671.08322291944, 39247.0, 40039.799801000954, 40064.59935400645, 40118.39822402666, 40294.39558406626, 8545.957270213656, 8623.137686231357, 8698.043215246318, 8708.21626053655, 8716.869246961302, 8514.531700756455, 8621.224089831914, 8648.091950345217, 8796.648134074629, 8804.075572064938, 8752.431091979033, 8766.60550275239, 8827.205551500363, 8833.0, 8860.24687901526, 8735.475871447701, 8743.387962842604, 8828.073052329477, 8867.955660221689, 8876.068012858686, 8593.097724738938, 8790.120987901222, 8816.382853200279, 8847.73456796297, 8856.070112638208, 39985.80007099975, 40553.391699124535, 40629.39055914163, 40638.187236255406, 40879.38680919789, 3396.609389920166, 3406.1654894550993, 3451.0, 3509.6314886937016, 3629.6551827576336, 28565.14304570866, 29209.85395073011, 29390.706092939225, 29603.555946660817, 29663.25841853949, 3882.6311500407414, 3923.3722604383447, 3923.7645741255333, 3924.7056470764805, 3941.8029098544957, 203015.0, 206565.0, 206740.0, 206754.0, 207471.96264018735, 56828.431715682316, 60645.39354606398, 62087.37912620816, 62297.68851155806, 65243.0, 62300.37699623036, 62490.687546561974, 62622.37377626257, 62765.68617156885, 62810.685946569974, 14844.0, 14863.851361486246, 14998.400063997537, 15061.0, 15146.469873554373, 11265.04247138986, 11316.886831131584, 11355.432228388547, 11367.772644547229, 11410.42947852604, 20973.580528389346, 21216.469588260108, 21406.357809265748, 22116.447088822588, 22210.44473888166, 8516.914830851736, 8691.261242794308, 8733.825323493495, 8808.163224493663, 8813.559322034002, 986.7335819328741, 1051.279873286801, 1063.4098075568133, 1073.8040706754705, 1080.065743132185, 28685.85657071743, 30636.69363306383, 31547.0, 31578.842105789325, 32049.0, 1031.489412740683, 1035.9430231337199, 1054.593981317183, 1055.9155267578576, 1064.80649861286, 14910.776338354934, 15138.394464221528, 15151.545453636409, 15269.9236503819, 15411.0, 371303.0, 374012.0, 374157.0, 374641.0, 376098.0, 52810.73594632002, 53062.73468632632, 53529.464705352446, 53598.7320063405, 53744.731276343366, 1357.178906761415, 1374.8625137486372, 1391.7703578909366, 1393.4078016843005, 1398.1611033380093, 28247.858760706065, 28779.27324360545, 29109.854450728457, 29233.123006309845, 29573.852130739207, 45838.77080614575, 46047.76976115098, 46391.0, 46421.0, 46442.30336545022, 292512.0, 292820.0, 294876.0, 295497.0, 296140.0, 31996.0, 44041.559584403745, 44169.0, 45045.32432013457, 45083.77458112688, 39856.402153968294, 40100.799496002335, 42078.0, 42420.151596968506, 43056.56943430651, 36077.81961090178, 36380.81809590935, 37053.44419833651, 37532.437013445364, 37926.0, 36025.63974360223, 36589.26821463609, 37059.25881482409, 37091.25817483689, 37312.626873730915, 32945.34109317848, 33503.83248083744, 33528.49707254442, 33786.66213337934, 33930.151746206546, 30658.233544161576, 32786.83606582047, 33166.834165829016, 33227.50158747669, 33662.663373365955, 24712.50574988454, 25037.624435633115, 25299.114530992065, 25400.74599253984, 25580.616290755283], "unit": "score", "name": "ext.html", "value": 18709.473328597593}, {"lowerIsBetter": false, "replicates": [361.71243861130404, 365.3879751416377, 365.9041171690786, 368.1073397012245, 372.60689972079444, 15766.763498547516, 16086.436974705888, 16848.578785530368, 17117.657646847056, 17762.111894405294, 15132.697346053072, 15319.77020344693, 15582.142982135978, 15603.219839008061, 16016.75974860378, 4873.122837889187, 5065.341505604285, 5067.949320506785, 5075.9492405076035, 5078.695278283315, 4078.225137223933, 4877.268409738532, 4958.876028099308, 4979.30289759434, 4995.400551933773, 4986.401631804189, 5024.246363045536, 5430.185472179165, 5611.523020543259, 5656.066748986413, 5305.920411193835, 5385.272988146589, 5477.780888764464, 5631.493165615094, 5658.0381335172915, 5132.794688212467, 5163.044836705221, 5168.9741551292, 5181.455947125535, 5209.348831396075, 14659.926700366537, 19434.80565194344, 19984.0, 20374.592508149755, 20439.284625038053, 2004.959900801976, 2019.1115908999993, 2076.0761461149796, 2091.006771783406, 2232.017912118679, 9310.906890931072, 9521.811661522173, 9553.426794392359, 10551.419671918042, 12950.87049129506, 1699.6005938604542, 1705.505403433003, 1745.677049745801, 1769.1684908093175, 1877.1271358818078, 40637.0, 52435.95128097455, 53213.733931330484, 55283.0, 55375.169372459444, 9915.157211636948, 9950.701478955643, 10050.949745251228, 10061.4466204358, 10333.896661033294, 12782.744345113046, 12837.358132093545, 12899.93550032244, 12905.741885162244, 12936.15914965543, 7402.629868506553, 7409.555426674309, 7427.108746950293, 7462.253774622603, 7510.136334321623, 7093.858122837514, 7148.320909513588, 7168.319009694071, 7169.4981351304905, 7184.1019872515935, 4135.545090040093, 4257.467816522934, 4446.4886538047895, 4456.888577785517, 4462.642988560908, 1781.8841775284566, 1837.4487653703836, 1871.4759867237196, 1885.9717104243448, 1887.9433616991512, 429.9656027517791, 434.0559283558248, 862.5945805471418, 910.1080940678172, 999.222162388561, 9654.27592930533, 10312.690619281433, 10324.174066074696, 10390.220733445021, 10398.844017339747, 453.9182947069493, 454.9112922979987, 457.44420529057356, 467.59319392129066, 472.3458010655199, 5757.683327417032, 5831.241938547962, 9403.717888463358, 10065.0, 10088.192944564416, 500418.0, 505893.0, 506304.0, 536223.0, 556519.0, 70347.29652703408, 71773.64113179401, 72826.0, 73780.0, 74108.2589174112, 1123.6404350607727, 1142.1890457775073, 1151.37825574189, 1151.6429906728774, 1155.1278784517635, 15089.47186848455, 15129.39482420691, 15179.241037948279, 15252.23738813077, 15513.45702900393, 32370.83814580912, 32460.51309230316, 33152.50271245981, 33480.0, 33856.0, 42774.0, 44600.10799784051, 45279.32081018853, 45619.543804562854, 46479.0, 7405.629718513945, 7525.924740752742, 7579.469437139347, 7593.620318984139, 7636.236376362319, 10326.328788628714, 10462.424566648908, 11050.944745276222, 11514.36670983104, 11524.0, 9546.99026408896, 9677.419354838778, 9708.514574271117, 9779.511024448606, 9897.901020989986, 9820.4107753535, 10144.644937427154, 10217.131543818561, 10218.54016569271, 10303.587856485656, 7022.40309573692, 10139.239557033105, 10279.537420815932, 10535.683929482127, 10613.893861061599, 9456.858147127936, 9695.175910047725, 9967.900320996987, 10280.537375817956, 10372.481375931324, 10394.856565777909, 10420.739481513023, 10564.261603585881, 10646.8935310649, 10740.624078157227], "unit": "score", "name": "jquery.html", "value": 7852.875700423044}, {"lowerIsBetter": false, "replicates": [1428.492885025816, 1480.851914808519, 1644.26830060623, 1787.7675902132721, 1815.2376002079125, 7902.802429939255, 7928.8810667840025, 8043.91956080439, 8155.836883262346, 8173.5504547249875, 8203.507789532618, 8268.958655206716, 8307.91692083079, 8342.74971750847, 8349.791255218623, 2322.3033090072954, 2341.613633750429, 2343.613303804879, 2355.316958082154, 2357.422431504275, 2381.1903952656094, 2415.516896620683, 2463.2117722328862, 2467.592847180213, 2469.555480013597, 2226.25420484138, 2238.630625946717, 2255.12050300383, 2393.8324317297797, 2470.950580988379, 2299.1493147535352, 2300.424893776556, 2315.4211447138214, 2323.1636610820174, 2324.0936034946385, 2375.5723969685623, 2406.9890645928576, 2407.65089062085, 2408.0, 2408.337707130536, 8154.306883914815, 8154.347652187811, 8218.547979861105, 8243.422960392774, 8296.336293096538, 4989.401271847365, 5064.5441910228255, 5073.162928116856, 5089.338386009832, 5092.10888094582, 3192.393445245396, 3197.2006998250436, 3295.0, 3323.9169020774675, 3327.1515763480156, 1010.1918465227861, 1014.9514351195021, 1035.0891215730185, 1065.4725910674188, 1078.946052697362, 11199.832002519886, 11343.0, 11426.314421134759, 11453.198276120675, 11533.653990380302, 4373.956260437419, 4424.778761061998, 4455.309427038749, 4466.531014243523, 4528.592426681548, 9153.679621213225, 9170.724878253663, 9199.724008279762, 9216.861747073799, 9236.445813251226, 4947.950520494821, 4970.627202959792, 4985.675931064469, 4987.476314986947, 4987.850364489072, 4507.301368287855, 4514.977425112919, 4522.751248681354, 4529.09418116378, 4561.612262957619, 3568.697425439696, 3690.28039532294, 3699.9445008324897, 3703.7407381483035, 3729.589745128034, 1132.8980391764617, 1134.9716257093473, 1136.3125309187988, 1140.8688000879838, 1161.9709507262387, 1098.8406681031365, 1100.5542755184003, 1134.489479734123, 1286.9034822388357, 1382.3641125082374, 7447.962760186273, 7501.699932002768, 7511.9624401877645, 7541.396688264926, 7583.05211848519, 1119.8096323625002, 1129.2321221569412, 1140.3670962615663, 1146.3981409759776, 1149.218531398657, 5906.8818623627285, 5924.229850119543, 5928.0, 5934.881302374015, 5980.222571065734, 9523.714288571355, 9693.903060969442, 9698.418094914186, 9846.852297215548, 9874.654387096418, 9540.809183816285, 9579.13787759091, 9584.233261339075, 9598.232141428669, 9693.0, 7326.0, 7716.0354955631665, 7750.341220996165, 7750.728724494728, 7780.988471498669, 7543.7736867894055, 7575.810604734926, 7720.420968427278, 7771.1840256774485, 7816.452848300564, 8820.735377938672, 8986.59560319774, 9019.0, 9025.729228123168, 9075.092490750872, 9103.863442048241, 9178.632854685738, 9228.261739060994, 9284.675036373694, 9550.665726699532, 7301.452391070585, 7378.11462624467, 7413.518121322312, 7437.442191835742, 7443.478956473212, 7716.498427602188, 7787.338076263581, 7819.609019548886, 7856.960715196387, 7879.172686868025, 6679.398854103154, 7397.519161254501, 7428.628568571442, 7457.440691948017, 7674.654640541301, 6964.338387853146, 6994.300569942965, 7069.363757261871, 7098.3256590623805, 7136.179339376038, 7219.386352160125, 7233.421326293778, 7274.01800756891, 7279.890801637874, 7313.853722925618, 6700.4639628830555, 6767.89848152288, 6804.319568043156, 6804.4216241620015, 6811.829704257433, 6650.068990341259, 6650.90023649636, 6694.364035416627, 6705.966470167813, 6726.125603671491], "unit": "score", "name": "mootools.html", "value": 4682.485800495347}, {"lowerIsBetter": false, "replicates": [338.27777694621983, 340.57258141033, 343.9914002149946, 348.4668457260392, 349.42345130534596, 6358.745650173993, 6363.395477429637, 6428.742850285983, 6449.774257900975, 6544.280129185786, 6315.621062736228, 6321.905171422421, 6326.968365158168, 6354.7775827846035, 6368.426841584256, 4807.855764327058, 4845.830395936143, 4851.126797176506, 4855.198892182786, 4868.342773725555, 4847.878803029917, 4864.14877396456, 4868.659193856432, 4870.902581948359, 4873.6832105913, 4611.239145540982, 4682.648801339896, 4690.671652984292, 4745.193317136095, 4799.3520874682, 4682.0, 4703.106409782147, 4703.3885594872445, 4708.081924024799, 4713.552212539803, 4083.9387409188885, 4103.938440923389, 4107.732997355192, 4131.752094874317, 4137.91724165518, 5984.521238300926, 5997.7001149942325, 6000.309964354112, 6027.849303767397, 6034.275886893601, 5495.6153069285165, 5516.724163791834, 5562.415946325658, 5571.526420254283, 5583.134614134816, 6665.200175978914, 6681.899771503431, 6701.296363881771, 6708.329167083301, 6721.966390168018, 4580.9692819115435, 4590.632749380042, 4591.770411479446, 4606.746628935407, 4612.7924243409125, 6916.135483064617, 6960.65196740166, 7038.0, 7042.119735033121, 7052.929470705279, 4706.317583950308, 4711.128441238382, 4714.4106986626675, 4717.858464246078, 4724.0, 4756.904861902743, 4758.333833263346, 4765.309030190603, 4770.284457331428, 4781.545753153445, 5477.370102438271, 5543.113101903676, 5543.279373681396, 5544.944550554443, 5551.916721249185, 6567.474602031826, 6681.799546013627, 6716.664166791641, 6760.83097922546, 6770.221424536143, 1628.5928517870532, 1650.4058538925976, 1675.852041351678, 1676.2875777794388, 1677.1195122560753, 1062.7236918401272, 1097.6268068856468, 1097.780443911221, 1102.1953973599318, 1105.850710154135, 6218.067289906459, 6223.159873417031, 6230.7819226326865, 6233.812985610439, 6239.78160764371, 6824.249332573413, 6871.553349032297, 6873.862522749517, 6877.277885822016, 6892.793216203522, 6074.51403887688, 6178.196834411588, 6182.258129024546, 6215.06773983897, 6233.2208473940755, 3714.7741245388956, 3717.7955212463035, 3723.069232691827, 3732.5520937487677, 3741.4948981887096, 7086.716531338792, 7106.324899134574, 7106.680199391039, 7125.42996560274, 7131.358177764027, 6830.077939478107, 6979.790606281819, 7003.124609423822, 7012.719491220396, 7024.2273349931465, 7077.752278670325, 7080.858382832417, 7089.751858684921, 7097.858042839114, 7110.431165506747, 6810.5913645181445, 6859.794206173823, 6866.965665171642, 6868.210155832143, 6876.071730316343, 6565.540412171103, 6659.367360100783, 6682.766103186365, 6704.899426508704, 6774.356436138559, 6944.826379340557, 6961.443084553122, 6967.442604591722, 6984.092068031124, 7122.786316410516, 4709.788059537261, 4724.362211101595, 4726.787294571821, 4730.36140121093, 4736.550027747358, 6647.368499992493, 6671.699773510107, 6885.070515480346, 6888.311168883071, 6893.724251029903, 6718.395344419026, 6878.759243426456, 6892.310768923067, 6895.4138898194215, 6895.724171033103, 6804.659767011729, 6815.352541508549, 6819.0, 6819.795406137824, 6829.965850170717, 6532.281449040697, 6645.269020407848, 6651.301613330531, 6686.7993960181275, 6692.297308782702, 6779.694913728796, 6852.760153394607, 6857.725690972505, 6866.107406037183, 6871.828204294932, 6661.933380666132, 6678.866422671616, 6680.732770689118, 6684.732610695518, 6686.498512611476], "unit": "score", "name": "prototype.html", "value": 5018.0468984204}, {"lowerIsBetter": false, "replicates": [787.2560430393279, 803.7789607857842, 813.5078277642028, 843.6288033265363, 850.5874650794364, 13400.1959882407, 13528.864711352884, 13539.864601353984, 13611.727765444697, 13615.183089014667, 12844.807327890088, 12875.420606072727, 12890.677733056678, 12965.74068518629, 12986.675333116676, 784.7096574267515, 801.1267718187174, 819.6557445872747, 823.3989187892842, 824.6783754335814, 809.8015986083388, 813.7721437997341, 817.3869597801648, 818.100089901107, 820.6471217376555, 859.2824991132412, 860.0968982568278, 861.7242482405633, 867.0635713429481, 867.8264347130568, 854.598338780772, 863.3481721300441, 863.5164307987548, 864.9308055355588, 865.3553102938288, 626.573929727785, 627.0093252660785, 632.4940047961612, 634.7651368993502, 636.312782195228, 14263.85736142646, 14391.496297629637, 14393.208373539452, 14408.279586020763, 14408.639784005483, 12790.0, 13071.477140914352, 13124.6718832029, 13205.669858253525, 13269.469221231138, 10107.393556386567, 10284.0, 10395.84406233907, 10950.945245273722, 11098.667039988732, 3516.982415087908, 3586.946195807065, 3618.3848745713294, 3671.430928206132, 3700.2229531798353, 52025.0, 52338.21492677613, 52544.47455525434, 52671.999999999614, 53132.46867531314, 9299.53502324881, 9362.955566650026, 9388.436693798394, 9689.757756056015, 9829.361091529028, 18162.364317249096, 18198.0, 18238.27046918135, 18293.63412731738, 18313.3590324338, 7244.348008679139, 7313.195548489662, 7406.370458511087, 7435.925640743631, 7559.811004724816, 4217.34631132175, 4230.1539692061715, 4258.361245813153, 4280.0, 4297.505786834491, 3188.091393952712, 3197.168736128623, 3207.3905957867933, 3212.4538828399227, 3228.5480032795426, 584.1383958661027, 609.5489337889929, 609.7256234694405, 609.7682880505469, 613.1844646619985, 515.487090345109, 583.5914859598298, 593.6052525070779, 600.3936024615083, 611.7491828350355, 7872.488288261245, 8070.9192908071345, 8284.50292982411, 8308.584570771438, 8664.91335086641, 632.4718859752066, 636.1952130554852, 644.6776611694153, 647.5984889368527, 685.4379408884766, 3848.9037774055314, 3871.5160604924386, 3950.6444420001762, 3969.563348031714, 3984.7031782515633, 55739.72130139404, 57307.0, 57418.13872791911, 58460.707696462094, 58836.11745823816, 44957.55042449533, 45493.77253113713, 45706.54293457089, 45827.54172458233, 45977.540224597324, 46074.30888536674, 46121.769391152826, 46674.76662616665, 47473.762631186626, 50364.20811606565, 8340.29107525867, 8399.832003360021, 8430.199131082783, 8640.0, 9116.498592577473, 34937.65062349445, 35037.82481087578, 35158.0, 36034.0, 36280.81859590685, 44784.77607611941, 45111.54888451073, 45652.315215272465, 45860.31209531926, 46315.768421159024, 10444.843327350247, 10838.349699018085, 10908.290961087503, 10958.506867190836, 11214.66356009321, 10613.840792387966, 10993.615223467461, 11842.822357664814, 12229.205101668364, 12356.0, 11139.944300278446, 11140.554377825121, 11241.66275011751, 11305.095592352427, 11598.594049208576, 11396.430178490877, 11639.359835208807, 11925.0, 11997.100217483548, 12024.639260822189, 10807.783844322912, 11296.887031129583, 11344.376059316817, 11468.483918223867, 12085.818712719492, 9015.864762028443, 9208.714627272326, 9240.907590924273, 9245.537723113952, 9333.393329433566, 8826.293896488394, 9310.906890931004, 9429.858552121861, 10091.596336146471, 10112.848307275544], "unit": "score", "name": "yui.html", "value": 6311.791060435828}], "name": "dromaeo_css", "value": 6984.594352711563}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 111.0, 109.0, 121.0, 111.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [150.0, 128.0, 145.0, 161.0, 128.0, 152.0, 153.0, 129.0, 167.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 164.0, 162.0, 161.0, 161.0, 160.0, 166.0, 167.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 75.0, 73.0, 71.0, 131.0, 72.0, 74.0, 79.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 138.0, 97.0, 95.0, 97.0, 147.0, 95.0, 97.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 112.0, 110.0, 111.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [60.0, 63.0, 60.0, 57.0, 60.0, 59.0, 61.0, 58.0, 67.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 69.0, 70.0, 69.0, 69.0, 70.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 85.0, 87.0, 86.0, 85.0, 87.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [127.0, 117.0, 119.0, 123.0, 113.0, 120.0, 123.0, 128.0, 123.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [143.0, 145.0, 144.0, 164.0, 156.0, 138.0, 149.0, 150.0, 151.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 69.0, 71.0, 68.0, 69.0, 71.0, 69.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1512.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.43409013893594], "unit": "score", "name": "Richards", "value": 208.35240399999998}, {"lowerIsBetter": false, "replicates": [194.21246844047388], "unit": "score", "name": "DeltaBlue", "value": 340.441582}, {"lowerIsBetter": false, "replicates": [283.2058906825262], "unit": "score", "name": "Encrypt", "value": 939.8851109999996}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [725.1631617113851], "unit": "score", "name": "Earley", "value": 919.0524770000003}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [41020.0], "unit": "score", "name": "RegExp", "value": 22.208313018039966}, {"lowerIsBetter": false, "replicates": [624.2197253433209], "unit": "score", "name": "Splay", "value": 130.54858199999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20104.05047253761}]} 06:04:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20104.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1512.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6984.60"}}} 06:04:34 INFO - Return code: 0 06:04:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:04:34 INFO - # TBPL SUCCESS # 06:04:34 INFO - Running post-action listener: _resource_record_post_action 06:04:34 INFO - Running post-run listener: _resource_record_post_run 06:04:35 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 16384; Write bytes: 327749632; Read time: 32; Write time: 255444 06:04:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 18071552; Read time: 0; Write time: 3428 06:04:35 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 16384; Write bytes: 309678080; Read time: 32; Write time: 252016 06:04:35 INFO - Running post-run listener: _upload_blobber_files 06:04:35 INFO - Blob upload gear active. 06:04:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:04:35 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:04:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:04:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:04:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:04:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:04:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:04:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:36 INFO - (blobuploader) - INFO - Done attempting. 06:04:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:04:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:04:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:42 INFO - (blobuploader) - INFO - Done attempting. 06:04:42 INFO - (blobuploader) - INFO - Iteration through files over. 06:04:42 INFO - Return code: 0 06:04:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:04:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:04:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4b6fcdb5ef4c93607735f68f3cfa799ef233d7aa675c4b73ae703956100046c83d2b8b96c8d113169cf8564a67dc239648adef3226c6e9629db18b1a1cdc100", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70e72ddc1514fb10187eb482b8e375d95d749fd92b012af88ba4ef2ffd9cd01bee4c7a891defa6632cfa2e5b3fe3ba20e742a6d15ceb93dcfac334265be152dd"} 06:04:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:04:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:04:42 INFO - Contents: 06:04:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4b6fcdb5ef4c93607735f68f3cfa799ef233d7aa675c4b73ae703956100046c83d2b8b96c8d113169cf8564a67dc239648adef3226c6e9629db18b1a1cdc100", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70e72ddc1514fb10187eb482b8e375d95d749fd92b012af88ba4ef2ffd9cd01bee4c7a891defa6632cfa2e5b3fe3ba20e742a6d15ceb93dcfac334265be152dd"} 06:04:42 INFO - Running post-run listener: copy_logs_to_upload_dir 06:04:42 INFO - Copying logs to upload dir... 06:04:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:04:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.514252 ========= master_lag: 48.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 17 secs) (at 2016-01-18 06:05:31.315089) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 06:05:31.319015) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496 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/c4b6fcdb5ef4c93607735f68f3cfa799ef233d7aa675c4b73ae703956100046c83d2b8b96c8d113169cf8564a67dc239648adef3226c6e9629db18b1a1cdc100", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70e72ddc1514fb10187eb482b8e375d95d749fd92b012af88ba4ef2ffd9cd01bee4c7a891defa6632cfa2e5b3fe3ba20e742a6d15ceb93dcfac334265be152dd"} build_url:https://queue.taskcluster.net/v1/task/bBsvr5z0SiGP0XfwfhitDQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/bBsvr5z0SiGP0XfwfhitDQ/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/c4b6fcdb5ef4c93607735f68f3cfa799ef233d7aa675c4b73ae703956100046c83d2b8b96c8d113169cf8564a67dc239648adef3226c6e9629db18b1a1cdc100", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70e72ddc1514fb10187eb482b8e375d95d749fd92b012af88ba4ef2ffd9cd01bee4c7a891defa6632cfa2e5b3fe3ba20e742a6d15ceb93dcfac334265be152dd"}' ========= master_lag: 0.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 06:05:31.521421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:05:31.523449) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453122173.571793-1751834496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:05:31.550862) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 06:05:31.551222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 06:05:32.116958) ========= ========= Total master_lag: 49.19 =========