builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1450919018.36 results: success (0) buildid: 20151223143006 builduid: be3853514eb045c48e867f290a7be73a revision: b92cd30cf34f0f4fee029c6ce21e727625aa7543 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.357622) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.358059) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.358346) ========= 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=d333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006444 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.392205) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.392508) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.446878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.447129) ========= 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=d333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.029976 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.497603) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.497897) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.498276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.498581) ========= 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=d333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 17:03:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-23 17:03:38 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101765 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.630347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.630662) ========= 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=d333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.109997 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.753400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:38.753766) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b92cd30cf34f0f4fee029c6ce21e727625aa7543 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b92cd30cf34f0f4fee029c6ce21e727625aa7543 --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=d333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 17:03:38,916 truncating revision to first 12 chars 2015-12-23 17:03:38,916 Setting DEBUG logging. 2015-12-23 17:03:38,916 attempt 1/10 2015-12-23 17:03:38,916 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b92cd30cf34f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 17:03:39,138 unpacking tar archive at: fx-team-b92cd30cf34f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.470338 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:39.235853) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:39.236160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:39.244876) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:39.245136) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 17:03:39.245540) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-23 17:03:39.245815) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=d333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:03:39 INFO - MultiFileLogger online at 20151223 17:03:39 in /builds/slave/test-pgo 17:03:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:03:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:03:39 INFO - {'append_to_log': False, 17:03:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:03:39 INFO - 'blob_upload_branch': 'Fx-Team', 17:03:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:03:39 INFO - 'branch': 'Fx-Team', 17:03:39 INFO - 'buildbot_json_path': 'buildprops.json', 17:03:39 INFO - 'config_files': ('talos/linux_config.py',), 17:03:39 INFO - 'default_actions': ('clobber', 17:03:39 INFO - 'read-buildbot-config', 17:03:39 INFO - 'download-and-extract', 17:03:39 INFO - 'populate-webroot', 17:03:39 INFO - 'create-virtualenv', 17:03:39 INFO - 'install', 17:03:39 INFO - 'run-tests'), 17:03:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:03:39 INFO - 'download_minidump_stackwalk': True, 17:03:39 INFO - 'download_symbols': 'ondemand', 17:03:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:03:39 INFO - 'tooltool.py': '/tools/tooltool.py', 17:03:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:03:39 INFO - '/tools/misc-python/virtualenv.py')}, 17:03:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:03:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:03:39 INFO - 'installer_path': 'installer.exe', 17:03:39 INFO - 'log_level': 'info', 17:03:39 INFO - 'log_name': 'talos', 17:03:39 INFO - 'log_to_console': True, 17:03:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:03:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:03:39 INFO - 'opt_config_files': (), 17:03:39 INFO - 'pip_index': False, 17:03:39 INFO - 'sps_profile': False, 17:03:39 INFO - 'sps_profile_interval': 0, 17:03:39 INFO - 'suite': 'dromaeojs-e10s', 17:03:39 INFO - 'system_bits': '64', 17:03:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:03:39 INFO - 'title': 'talos-linux64-ix-051', 17:03:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:03:39 INFO - 'use_talos_json': True, 17:03:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:03:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:03:39 INFO - 'work_dir': 'build'} 17:03:39 INFO - ##### 17:03:39 INFO - ##### Running clobber step. 17:03:39 INFO - ##### 17:03:39 INFO - Running pre-action listener: _resource_record_pre_action 17:03:39 INFO - Running main action method: clobber 17:03:39 INFO - rmtree: /builds/slave/test-pgo/build 17:03:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:03:40 INFO - Running post-action listener: _resource_record_post_action 17:03:40 INFO - ##### 17:03:40 INFO - ##### Running read-buildbot-config step. 17:03:40 INFO - ##### 17:03:40 INFO - Running pre-action listener: _resource_record_pre_action 17:03:40 INFO - Running main action method: read_buildbot_config 17:03:40 INFO - Using buildbot properties: 17:03:40 INFO - { 17:03:40 INFO - "project": "", 17:03:40 INFO - "product": "firefox", 17:03:40 INFO - "script_repo_revision": "production", 17:03:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:03:40 INFO - "repository": "", 17:03:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:03:40 INFO - "buildid": "20151223143006", 17:03:40 INFO - "pgo_build": "True", 17:03:40 INFO - "basedir": "/builds/slave/test-pgo", 17:03:40 INFO - "buildnumber": 116, 17:03:40 INFO - "slavename": "talos-linux64-ix-051", 17:03:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:03:40 INFO - "platform": "ubuntu64_hw", 17:03:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:03:40 INFO - "branch": "fx-team", 17:03:40 INFO - "repo_path": "integration/fx-team", 17:03:40 INFO - "revision": "b92cd30cf34f0f4fee029c6ce21e727625aa7543", 17:03:40 INFO - "stage_platform": "linux64-pgo", 17:03:40 INFO - "builduid": "be3853514eb045c48e867f290a7be73a", 17:03:40 INFO - "slavebuilddir": "test" 17:03:40 INFO - } 17:03:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:03:40 INFO - Running post-action listener: _resource_record_post_action 17:03:40 INFO - ##### 17:03:40 INFO - ##### Running download-and-extract step. 17:03:40 INFO - ##### 17:03:40 INFO - Running pre-action listener: _resource_record_pre_action 17:03:40 INFO - Running main action method: download_and_extract 17:03:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:40 INFO - https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:03:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/test_packages.json 17:03:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/test_packages.json 17:03:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:03:50 INFO - Downloaded 1302 bytes. 17:03:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:03:50 INFO - Using the following test package requirements: 17:03:50 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:50 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:03:50 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'jsshell-linux-x86_64.zip'], 17:03:50 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:03:50 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:50 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:03:50 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:03:50 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:03:50 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:50 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:03:50 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:50 INFO - https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/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 17:03:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/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 17:03:56 INFO - Downloaded 23181303 bytes. 17:03:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:03:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:03:57 INFO - Return code: 0 17:03:57 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 17:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:57 INFO - https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/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 17:03:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/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 17:03:59 INFO - Downloaded 23181303 bytes. 17:03:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:03:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:04:00 INFO - Return code: 0 17:04: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')]} 17:04:00 INFO - https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:04:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/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 17:04:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/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 17:04:01 INFO - Downloaded 11132277 bytes. 17:04:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 17:04:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:04:01 INFO - Return code: 0 17:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:01 INFO - https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:04:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/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 17:04:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/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 17:04:03 INFO - Downloaded 54844985 bytes. 17:04:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:03 INFO - mkdir: /builds/slave/test-pgo/properties 17:04:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:04:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:04:03 INFO - Contents: 17:04:03 INFO - build_url:https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:03 INFO - Running post-action listener: _resource_record_post_action 17:04:03 INFO - Running post-action listener: set_extra_try_arguments 17:04:03 INFO - ##### 17:04:03 INFO - ##### Running populate-webroot step. 17:04:03 INFO - ##### 17:04:03 INFO - Running pre-action listener: _resource_record_pre_action 17:04:03 INFO - Running main action method: populate_webroot 17:04:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:03 INFO - '--tppagecycles', 17:04:03 INFO - '7'], 17:04:03 INFO - 'tests': ['tsvgm']}}, 17:04:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:04:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:04:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:04:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:03 INFO - 'talos_options': ['--e10s'], 17:04:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:03 INFO - 'tests': ['damp', 'tps']}, 17:04:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:03 INFO - 'talos_options': ['--e10s'], 17:04:03 INFO - 'tests': ['damp', 'tps']}, 17:04:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:04:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:03 INFO - 'other': {'tests': ['a11yr', 17:04:03 INFO - 'ts_paint', 17:04:03 INFO - 'tpaint', 17:04:03 INFO - 'sessionrestore', 17:04:03 INFO - 'sessionrestore_no_auto_restore']}, 17:04:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:04:03 INFO - 'tests': ['a11yr', 17:04:03 INFO - 'ts_paint', 17:04:03 INFO - 'tpaint', 17:04:03 INFO - 'sessionrestore', 17:04:03 INFO - 'sessionrestore_no_auto_restore']}, 17:04:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:04:03 INFO - 'tests': ['a11yr', 17:04:03 INFO - 'ts_paint', 17:04:03 INFO - 'tpaint', 17:04:03 INFO - 'sessionrestore', 17:04:03 INFO - 'sessionrestore_no_auto_restore']}, 17:04:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:04:03 INFO - 'tests': ['a11yr', 17:04:03 INFO - 'ts_paint', 17:04:03 INFO - 'tpaint', 17:04:03 INFO - 'sessionrestore', 17:04:03 INFO - 'sessionrestore_no_auto_restore']}, 17:04:03 INFO - 'other_l64': {'tests': ['a11yr', 17:04:03 INFO - 'ts_paint', 17:04:03 INFO - 'tpaint', 17:04:03 INFO - 'sessionrestore', 17:04:03 INFO - 'sessionrestore_no_auto_restore']}, 17:04:03 INFO - 'other_nol64': {'tests': ['a11yr', 17:04:03 INFO - 'ts_paint', 17:04:03 INFO - 'tpaint', 17:04:03 INFO - 'sessionrestore', 17:04:03 INFO - 'sessionrestore_no_auto_restore']}, 17:04:03 INFO - 'svgr': {'tests': ['tsvgx', 17:04:03 INFO - 'tsvgr_opacity', 17:04:03 INFO - 'tart', 17:04:03 INFO - 'tscrollx', 17:04:03 INFO - 'cart']}, 17:04:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:04:03 INFO - 'tests': ['tsvgx', 17:04:03 INFO - 'tsvgr_opacity', 17:04:03 INFO - 'tart', 17:04:03 INFO - 'tscrollx', 17:04:03 INFO - 'cart']}, 17:04:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:03 INFO - 'tests': ['tp5o']}, 17:04:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:03 INFO - 'talos_options': ['--e10s'], 17:04:03 INFO - 'tests': ['tp5o']}, 17:04:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:03 INFO - 'talos_options': ['--xperf_path', 17:04:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:03 INFO - 'tests': ['tp5n']}, 17:04:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:03 INFO - 'talos_options': ['--e10s', 17:04:03 INFO - '--xperf_path', 17:04:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:03 INFO - 'tests': ['tp5n']}}, 17:04:03 INFO - 'talos.zip': {'path': '', 17:04:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:03 INFO - Running post-action listener: _resource_record_post_action 17:04:03 INFO - ##### 17:04:03 INFO - ##### Running create-virtualenv step. 17:04:03 INFO - ##### 17:04:03 INFO - Running pre-action listener: _resource_record_pre_action 17:04:03 INFO - Running main action method: create_virtualenv 17:04:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:04:03 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 17:04:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:04:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:03 INFO - Using real prefix '/usr' 17:04:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:04:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:06 INFO - Installing pip.................done. 17:04:06 INFO - Return code: 0 17:04:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:06 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 0x7fa47dfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38660>, '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 0x2c39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39a10>, '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': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', '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 17:04:06 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 17:04:06 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 17:04:06 INFO - Using env: {'DISPLAY': ':0', 17:04:06 INFO - 'HOME': '/home/cltbld', 17:04:06 INFO - 'LANG': 'en_US.UTF-8', 17:04:06 INFO - 'LANGUAGE': 'en_US:en', 17:04:06 INFO - 'LOGNAME': 'cltbld', 17:04:06 INFO - 'MAIL': '/var/mail/cltbld', 17:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:06 INFO - 'MOZ_NO_REMOTE': '1', 17:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:06 INFO - 'NO_EM_RESTART': '1', 17:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:06 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:06 INFO - 'SHELL': '/bin/bash', 17:04:06 INFO - 'SHLVL': '1', 17:04:06 INFO - 'TERM': 'linux', 17:04:06 INFO - 'TMOUT': '86400', 17:04:06 INFO - 'USER': 'cltbld', 17:04:06 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', 17:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:06 INFO - '_': '/tools/buildbot/bin/python'} 17:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:06 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 17:04:06 INFO - Cleaning up... 17:04:06 INFO - Return code: 0 17:04:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:06 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 0x7fa47dfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38660>, '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 0x2c39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39a10>, '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': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', '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 17:04:06 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 17:04:06 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 17:04:06 INFO - Using env: {'DISPLAY': ':0', 17:04:06 INFO - 'HOME': '/home/cltbld', 17:04:06 INFO - 'LANG': 'en_US.UTF-8', 17:04:06 INFO - 'LANGUAGE': 'en_US:en', 17:04:06 INFO - 'LOGNAME': 'cltbld', 17:04:06 INFO - 'MAIL': '/var/mail/cltbld', 17:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:06 INFO - 'MOZ_NO_REMOTE': '1', 17:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:06 INFO - 'NO_EM_RESTART': '1', 17:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:06 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:06 INFO - 'SHELL': '/bin/bash', 17:04:06 INFO - 'SHLVL': '1', 17:04:06 INFO - 'TERM': 'linux', 17:04:06 INFO - 'TMOUT': '86400', 17:04:06 INFO - 'USER': 'cltbld', 17:04:06 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', 17:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:06 INFO - '_': '/tools/buildbot/bin/python'} 17:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:06 INFO - Downloading/unpacking psutil>=0.7.1 17:04:06 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 17:04:06 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 17:04:06 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 17:04:06 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 17:04:06 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 17:04:06 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 17:04:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:04:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:04:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:08 INFO - Installing collected packages: psutil 17:04:08 INFO - Running setup.py install for psutil 17:04:08 INFO - building 'psutil._psutil_linux' extension 17:04:08 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 17:04:08 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 17:04:08 INFO - building 'psutil._psutil_posix' extension 17:04:08 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 17:04:08 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 17:04:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:09 INFO - Successfully installed psutil 17:04:09 INFO - Cleaning up... 17:04:09 INFO - Return code: 0 17:04:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:09 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 0x7fa47dfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38660>, '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 0x2c39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39a10>, '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': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', '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 17:04:09 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 17:04:09 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 17:04:09 INFO - Using env: {'DISPLAY': ':0', 17:04:09 INFO - 'HOME': '/home/cltbld', 17:04:09 INFO - 'LANG': 'en_US.UTF-8', 17:04:09 INFO - 'LANGUAGE': 'en_US:en', 17:04:09 INFO - 'LOGNAME': 'cltbld', 17:04:09 INFO - 'MAIL': '/var/mail/cltbld', 17:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:09 INFO - 'MOZ_NO_REMOTE': '1', 17:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:09 INFO - 'NO_EM_RESTART': '1', 17:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:09 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:09 INFO - 'SHELL': '/bin/bash', 17:04:09 INFO - 'SHLVL': '1', 17:04:09 INFO - 'TERM': 'linux', 17:04:09 INFO - 'TMOUT': '86400', 17:04:09 INFO - 'USER': 'cltbld', 17:04:09 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', 17:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:09 INFO - '_': '/tools/buildbot/bin/python'} 17:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:04:09 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 17:04:09 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 17:04:09 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 17:04:09 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 17:04:09 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 17:04:09 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 17:04:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:04:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:04:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:04:11 INFO - Installing collected packages: mozsystemmonitor 17:04:11 INFO - Running setup.py install for mozsystemmonitor 17:04:11 INFO - Successfully installed mozsystemmonitor 17:04:11 INFO - Cleaning up... 17:04:11 INFO - Return code: 0 17:04:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:04:11 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')]} 17:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 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')]} 17:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 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 0x7fa47dfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38660>, '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 0x2c39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39a10>, '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': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', '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 17:04:11 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 17:04:11 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 17:04:11 INFO - Using env: {'DISPLAY': ':0', 17:04:11 INFO - 'HOME': '/home/cltbld', 17:04:11 INFO - 'LANG': 'en_US.UTF-8', 17:04:11 INFO - 'LANGUAGE': 'en_US:en', 17:04:11 INFO - 'LOGNAME': 'cltbld', 17:04:11 INFO - 'MAIL': '/var/mail/cltbld', 17:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:11 INFO - 'MOZ_NO_REMOTE': '1', 17:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:11 INFO - 'NO_EM_RESTART': '1', 17:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:11 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:11 INFO - 'SHELL': '/bin/bash', 17:04:11 INFO - 'SHLVL': '1', 17:04:11 INFO - 'TERM': 'linux', 17:04:11 INFO - 'TMOUT': '86400', 17:04:11 INFO - 'USER': 'cltbld', 17:04:11 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', 17:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:11 INFO - '_': '/tools/buildbot/bin/python'} 17:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:11 INFO - Downloading/unpacking blobuploader==1.2.4 17:04:11 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 17:04:11 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 17:04:11 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 17:04:11 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 17:04:11 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 17:04:11 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 17:04:13 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:04:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04:13 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 17:04:13 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 17:04:13 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 17:04:13 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 17:04:13 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 17:04:13 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 17:04:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:04:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:04:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04:13 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 17:04:13 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 17:04:13 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 17:04:13 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 17:04:13 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 17:04:13 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 17:04:13 INFO - Downloading docopt-0.6.1.tar.gz 17:04:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:04:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:13 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:13 INFO - Running setup.py install for blobuploader 17:04:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:04:13 INFO - Running setup.py install for requests 17:04:14 INFO - Running setup.py install for docopt 17:04:14 INFO - Successfully installed blobuploader requests docopt 17:04:14 INFO - Cleaning up... 17:04:14 INFO - Return code: 0 17:04:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:14 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 0x7fa47dfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38660>, '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 0x2c39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39a10>, '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': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', '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 17:04:14 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 17:04:14 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 17:04:14 INFO - Using env: {'DISPLAY': ':0', 17:04:14 INFO - 'HOME': '/home/cltbld', 17:04:14 INFO - 'LANG': 'en_US.UTF-8', 17:04:14 INFO - 'LANGUAGE': 'en_US:en', 17:04:14 INFO - 'LOGNAME': 'cltbld', 17:04:14 INFO - 'MAIL': '/var/mail/cltbld', 17:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:14 INFO - 'MOZ_NO_REMOTE': '1', 17:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:14 INFO - 'NO_EM_RESTART': '1', 17:04:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:14 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:14 INFO - 'SHELL': '/bin/bash', 17:04:14 INFO - 'SHLVL': '1', 17:04:14 INFO - 'TERM': 'linux', 17:04:14 INFO - 'TMOUT': '86400', 17:04:14 INFO - 'USER': 'cltbld', 17:04:14 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', 17:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:14 INFO - '_': '/tools/buildbot/bin/python'} 17:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:14 INFO - Running setup.py (path:/tmp/pip-VrRmwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:14 INFO - Running setup.py (path:/tmp/pip-M_XZ3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:14 INFO - Running setup.py (path:/tmp/pip-bv_bjQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:14 INFO - Running setup.py (path:/tmp/pip-F4eERz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:14 INFO - Running setup.py (path:/tmp/pip-Zv8WHB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:14 INFO - Running setup.py (path:/tmp/pip-dyVJ8g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:14 INFO - Running setup.py (path:/tmp/pip-VIvWnu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:15 INFO - Running setup.py (path:/tmp/pip-KzRjwA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:15 INFO - Running setup.py (path:/tmp/pip-BV18Oy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:15 INFO - Running setup.py (path:/tmp/pip-tEj1nD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:15 INFO - Running setup.py (path:/tmp/pip-WZyZGq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:15 INFO - Running setup.py (path:/tmp/pip-miPAhS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:15 INFO - Running setup.py (path:/tmp/pip-qLUKg3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:15 INFO - Running setup.py (path:/tmp/pip-SkaPrF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:15 INFO - Running setup.py (path:/tmp/pip-o5PQi6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:15 INFO - Running setup.py (path:/tmp/pip-g1GO2C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:15 INFO - Running setup.py (path:/tmp/pip-ElOIx1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:15 INFO - Running setup.py install for manifestparser 17:04:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:04:15 INFO - Running setup.py install for mozcrash 17:04:15 INFO - Running setup.py install for mozdebug 17:04:16 INFO - Running setup.py install for mozdevice 17:04:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Running setup.py install for mozfile 17:04:16 INFO - Running setup.py install for mozhttpd 17:04:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Running setup.py install for mozinfo 17:04:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Running setup.py install for mozInstall 17:04:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Running setup.py install for mozleak 17:04:16 INFO - Running setup.py install for mozlog 17:04:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Running setup.py install for moznetwork 17:04:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Running setup.py install for mozprocess 17:04:17 INFO - Running setup.py install for mozprofile 17:04:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Running setup.py install for mozrunner 17:04:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Running setup.py install for mozscreenshot 17:04:17 INFO - Running setup.py install for moztest 17:04:17 INFO - Running setup.py install for mozversion 17:04:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:17 INFO - Cleaning up... 17:04:17 INFO - Return code: 0 17:04:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:17 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')]} 17:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:17 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')]} 17:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:17 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 0x7fa47dfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38660>, '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 0x2c39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39a10>, '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': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', '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 17:04:17 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 17:04:17 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 17:04:17 INFO - Using env: {'DISPLAY': ':0', 17:04:17 INFO - 'HOME': '/home/cltbld', 17:04:17 INFO - 'LANG': 'en_US.UTF-8', 17:04:17 INFO - 'LANGUAGE': 'en_US:en', 17:04:17 INFO - 'LOGNAME': 'cltbld', 17:04:17 INFO - 'MAIL': '/var/mail/cltbld', 17:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:17 INFO - 'MOZ_NO_REMOTE': '1', 17:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:17 INFO - 'NO_EM_RESTART': '1', 17:04:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:17 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:17 INFO - 'SHELL': '/bin/bash', 17:04:17 INFO - 'SHLVL': '1', 17:04:17 INFO - 'TERM': 'linux', 17:04:17 INFO - 'TMOUT': '86400', 17:04:17 INFO - 'USER': 'cltbld', 17:04:17 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', 17:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:17 INFO - '_': '/tools/buildbot/bin/python'} 17:04:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:17 INFO - Running setup.py (path:/tmp/pip-Z2Fq2Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:17 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)) 17:04:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:17 INFO - Running setup.py (path:/tmp/pip-GMLx2y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:17 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)) 17:04:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:17 INFO - Running setup.py (path:/tmp/pip-3r8OqC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:18 INFO - Running setup.py (path:/tmp/pip-a2Xku8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:18 INFO - Running setup.py (path:/tmp/pip-xKzxCm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:18 INFO - Running setup.py (path:/tmp/pip-SLX956-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:18 INFO - Running setup.py (path:/tmp/pip-aDHxf6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:18 INFO - Running setup.py (path:/tmp/pip-zTcAE_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:18 INFO - Running setup.py (path:/tmp/pip-nUv0H2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:18 INFO - Running setup.py (path:/tmp/pip-ibURDi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:18 INFO - Running setup.py (path:/tmp/pip-81_UMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:18 INFO - Running setup.py (path:/tmp/pip-6Saiek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:18 INFO - Running setup.py (path:/tmp/pip-LspRZn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:18 INFO - Running setup.py (path:/tmp/pip-Nqiz3D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:18 INFO - Running setup.py (path:/tmp/pip-tozHh6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:18 INFO - Running setup.py (path:/tmp/pip-r7_m88-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:18 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)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:18 INFO - Running setup.py (path:/tmp/pip-HgYTZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:19 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:19 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 17:04:19 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 17:04:19 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 17:04:19 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 17:04:19 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 17:04:19 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 17:04:20 INFO - Downloading blessings-1.5.1.tar.gz 17:04:20 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 17:04:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:20 INFO - Installing collected packages: blessings 17:04:20 INFO - Running setup.py install for blessings 17:04:20 INFO - Successfully installed blessings 17:04:20 INFO - Cleaning up... 17:04:20 INFO - Return code: 0 17:04:20 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:04:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:04:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:04:21 INFO - Reading from file tmpfile_stdout 17:04:21 INFO - Current package versions: 17:04:21 INFO - argparse == 1.2.1 17:04:21 INFO - blessings == 1.5.1 17:04:21 INFO - blobuploader == 1.2.4 17:04:21 INFO - docopt == 0.6.1 17:04:21 INFO - manifestparser == 1.1 17:04:21 INFO - mozInstall == 1.12 17:04:21 INFO - mozcrash == 0.16 17:04:21 INFO - mozdebug == 0.1 17:04:21 INFO - mozdevice == 0.47 17:04:21 INFO - mozfile == 1.2 17:04:21 INFO - mozhttpd == 0.7 17:04:21 INFO - mozinfo == 0.9 17:04:21 INFO - mozleak == 0.1 17:04:21 INFO - mozlog == 3.1 17:04:21 INFO - moznetwork == 0.27 17:04:21 INFO - mozprocess == 0.22 17:04:21 INFO - mozprofile == 0.28 17:04:21 INFO - mozrunner == 6.11 17:04:21 INFO - mozscreenshot == 0.1 17:04:21 INFO - mozsystemmonitor == 0.0 17:04:21 INFO - moztest == 0.7 17:04:21 INFO - mozversion == 1.4 17:04:21 INFO - psutil == 3.1.1 17:04:21 INFO - requests == 1.2.3 17:04:21 INFO - wsgiref == 0.1.2 17:04:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 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 0x7fa47dfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38660>, '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 0x2c39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39a10>, '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': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', '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 17:04:21 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 17:04:21 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 17:04:21 INFO - Using env: {'DISPLAY': ':0', 17:04:21 INFO - 'HOME': '/home/cltbld', 17:04:21 INFO - 'LANG': 'en_US.UTF-8', 17:04:21 INFO - 'LANGUAGE': 'en_US:en', 17:04:21 INFO - 'LOGNAME': 'cltbld', 17:04:21 INFO - 'MAIL': '/var/mail/cltbld', 17:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:21 INFO - 'MOZ_NO_REMOTE': '1', 17:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:21 INFO - 'NO_EM_RESTART': '1', 17:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:21 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:21 INFO - 'SHELL': '/bin/bash', 17:04:21 INFO - 'SHLVL': '1', 17:04:21 INFO - 'TERM': 'linux', 17:04:21 INFO - 'TMOUT': '86400', 17:04:21 INFO - 'USER': 'cltbld', 17:04:21 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', 17:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:21 INFO - '_': '/tools/buildbot/bin/python'} 17:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:21 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)) 17:04:21 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)) 17:04:21 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)) 17:04:21 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)) 17:04:21 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)) 17:04:21 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)) 17:04:21 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)) 17:04:21 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)) 17:04:21 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)) 17:04:21 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)) 17:04:21 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)) 17:04:21 INFO - Cleaning up... 17:04:21 INFO - Return code: 0 17:04:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 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 0x7fa47dfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38660>, '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 0x2c39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39a10>, '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': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', '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 17:04:21 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 17:04:21 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 17:04:21 INFO - Using env: {'DISPLAY': ':0', 17:04:21 INFO - 'HOME': '/home/cltbld', 17:04:21 INFO - 'LANG': 'en_US.UTF-8', 17:04:21 INFO - 'LANGUAGE': 'en_US:en', 17:04:21 INFO - 'LOGNAME': 'cltbld', 17:04:21 INFO - 'MAIL': '/var/mail/cltbld', 17:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:21 INFO - 'MOZ_NO_REMOTE': '1', 17:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:21 INFO - 'NO_EM_RESTART': '1', 17:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:21 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:21 INFO - 'SHELL': '/bin/bash', 17:04:21 INFO - 'SHLVL': '1', 17:04:21 INFO - 'TERM': 'linux', 17:04:21 INFO - 'TMOUT': '86400', 17:04:21 INFO - 'USER': 'cltbld', 17:04:21 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', 17:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:21 INFO - '_': '/tools/buildbot/bin/python'} 17:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:21 INFO - Downloading/unpacking jsonschema 17:04:21 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 17:04:21 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 17:04:21 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 17:04:21 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 17:04:21 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 17:04:21 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 17:04:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:23 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 17:04:23 INFO - Downloading/unpacking functools32 (from jsonschema) 17:04:23 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 17:04:23 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 17:04:23 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 17:04:23 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 17:04:23 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 17:04:23 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 17:04:23 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:04:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:23 INFO - warning: no files found matching '*.txt' 17:04:23 INFO - no previously-included directories found matching 'build' 17:04:23 INFO - no previously-included directories found matching 'dist' 17:04:23 INFO - no previously-included directories found matching '.git*' 17:04:23 INFO - Installing collected packages: jsonschema, functools32 17:04:23 INFO - Running setup.py install for functools32 17:04:23 INFO - warning: no files found matching '*.txt' 17:04:23 INFO - no previously-included directories found matching 'build' 17:04:23 INFO - no previously-included directories found matching 'dist' 17:04:23 INFO - no previously-included directories found matching '.git*' 17:04:23 INFO - Successfully installed jsonschema functools32 17:04:23 INFO - Cleaning up... 17:04:23 INFO - Return code: 0 17:04:23 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:04:23 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')]} 17:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:23 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')]} 17:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:23 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 0x7fa47dfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38660>, '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 0x2c39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39a10>, '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': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', '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 17:04:23 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 17:04:23 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 17:04:23 INFO - Using env: {'DISPLAY': ':0', 17:04:23 INFO - 'HOME': '/home/cltbld', 17:04:23 INFO - 'LANG': 'en_US.UTF-8', 17:04:23 INFO - 'LANGUAGE': 'en_US:en', 17:04:23 INFO - 'LOGNAME': 'cltbld', 17:04:23 INFO - 'MAIL': '/var/mail/cltbld', 17:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:23 INFO - 'MOZ_NO_REMOTE': '1', 17:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:23 INFO - 'NO_EM_RESTART': '1', 17:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:23 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:23 INFO - 'SHELL': '/bin/bash', 17:04:23 INFO - 'SHLVL': '1', 17:04:23 INFO - 'TERM': 'linux', 17:04:23 INFO - 'TMOUT': '86400', 17:04:23 INFO - 'USER': 'cltbld', 17:04:23 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', 17:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:23 INFO - '_': '/tools/buildbot/bin/python'} 17:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:23 INFO - Downloading/unpacking flake8 17:04:23 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 17:04:23 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 17:04:23 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 17:04:23 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 17:04:23 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 17:04:23 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 17:04:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:04:25 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 17:04:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:04:25 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 17:04:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:04:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:04:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:26 INFO - no previously-included directories found matching 'docs/_build' 17:04:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:04:26 INFO - Running setup.py install for pep8 17:04:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:26 INFO - no previously-included directories found matching 'docs/_build' 17:04:26 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:04:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:04:26 INFO - Cleaning up... 17:04:26 INFO - Return code: 0 17:04:26 INFO - Running post-action listener: _resource_record_post_action 17:04:26 INFO - Running post-action listener: _start_resource_monitoring 17:04:26 INFO - Starting resource monitoring. 17:04:26 INFO - ##### 17:04:26 INFO - ##### Running install step. 17:04:26 INFO - ##### 17:04:26 INFO - Running pre-action listener: _resource_record_pre_action 17:04:26 INFO - Running main action method: install 17:04:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:04:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:04:26 INFO - Reading from file tmpfile_stdout 17:04:26 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:04:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:04:26 INFO - Reading from file tmpfile_stdout 17:04:26 INFO - Output received: 17:04:26 INFO - Usage: mozinstall [options] installer 17:04:26 INFO - Options: 17:04:26 INFO - -h, --help show this help message and exit 17:04:26 INFO - -d DEST, --destination=DEST 17:04:26 INFO - Directory to install application into. [default: 17:04:26 INFO - "/builds/slave/test-pgo"] 17:04:26 INFO - --app=APP Application being installed. [default: firefox] 17:04:26 INFO - mkdir: /builds/slave/test-pgo/build/application 17:04:26 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'] 17:04:26 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 17:04:42 INFO - Reading from file tmpfile_stdout 17:04:42 INFO - Output received: 17:04:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:04:42 INFO - Running post-action listener: _resource_record_post_action 17:04:42 INFO - ##### 17:04:42 INFO - ##### Running run-tests step. 17:04:42 INFO - ##### 17:04:42 INFO - Running pre-action listener: _resource_record_pre_action 17:04:42 INFO - Running main action method: run_tests 17:04:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:04:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:04:42 INFO - Python 2.7.3 17:04:42 INFO - Return code: 0 17:04:42 INFO - grabbing minidump binary from tooltool 17:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:42 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 0x2c38660>, '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 0x2c39560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:04:42 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 17:04:42 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 17:04:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:42 INFO - Return code: 0 17:04:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:04:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:04:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:04:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:04:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:04:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:04:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:04:43 INFO - Return code: 0 17:04:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:04:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 17:04:43 INFO - Using env: {'DISPLAY': ':0', 17:04:43 INFO - 'HOME': '/home/cltbld', 17:04:43 INFO - 'LANG': 'en_US.UTF-8', 17:04:43 INFO - 'LANGUAGE': 'en_US:en', 17:04:43 INFO - 'LOGNAME': 'cltbld', 17:04:43 INFO - 'MAIL': '/var/mail/cltbld', 17:04:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:04:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:43 INFO - 'MOZ_NO_REMOTE': '1', 17:04:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:43 INFO - 'NO_EM_RESTART': '1', 17:04:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:43 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:04:43 INFO - 'SHELL': '/bin/bash', 17:04:43 INFO - 'SHLVL': '1', 17:04:43 INFO - 'TERM': 'linux', 17:04:43 INFO - 'TMOUT': '86400', 17:04:43 INFO - 'USER': 'cltbld', 17:04:43 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608', 17:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:43 INFO - '_': '/tools/buildbot/bin/python'} 17:04:43 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:04:43 INFO - mozversion application_buildid: 20151223143006 17:04:43 INFO - mozversion application_changeset: b92cd30cf34f0f4fee029c6ce21e727625aa7543 17:04:43 INFO - mozversion application_display_name: Nightly 17:04:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:43 INFO - mozversion application_name: Firefox 17:04:43 INFO - mozversion application_remotingname: firefox 17:04:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:04:43 INFO - mozversion application_vendor: Mozilla 17:04:43 INFO - mozversion application_version: 46.0a1 17:04:43 INFO - mozversion platform_buildid: 20151223143006 17:04:43 INFO - mozversion platform_changeset: b92cd30cf34f0f4fee029c6ce21e727625aa7543 17:04:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:04:43 INFO - mozversion platform_version: 46.0a1 17:04:43 INFO - using testdate: 1450919083 17:04:43 INFO - actual date: 1450919083 17:04:43 INFO - starting webserver on 'localhost:38194' 17:04:43 INFO - SUITE-START | Running 3 tests 17:04:43 INFO - TEST-START | dromaeo_css 17:04:43 INFO - operating with platform_type : linux_ 17:04:43 INFO - Initialising browser for dromaeo_css test... 17:04:43 INFO - TEST-INFO | started process 9644 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc2cOT1/profile http://localhost:38194/getInfo.html) 17:04:48 INFO - PROCESS | 9644 | __metrics Screen width/height:1600/1200 17:04:48 INFO - PROCESS | 9644 | colorDepth:24 17:04:48 INFO - PROCESS | 9644 | Browser inner width/height: 1024/697 17:04:48 INFO - PROCESS | 9644 | __metrics 17:04:48 INFO - PROCESS | 9644 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:04:49 INFO - TEST-INFO | 9644: exit 0 17:04:49 INFO - Browser initialized. 17:04:49 INFO - Running cycle 1/1 for dromaeo_css test... 17:04:49 INFO - TEST-INFO | started process 9776 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc2cOT1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:01 INFO - PROCESS | 9776 | RSS: Main: 149434368 17:05:01 INFO - PROCESS | 9776 | 17:05:50 INFO - PROCESS | 9776 | 1450919150759 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] 17:07:59 INFO - PROCESS | 9776 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38194/tests/dromaeo/cssquery-ext.html) 17:08:01 INFO - PROCESS | 9776 | RSS: Main: 158580736 17:08:01 INFO - PROCESS | 9776 | 17:11:03 INFO - PROCESS | 9776 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-ext.html (next: http://localhost:38194/tests/dromaeo/cssquery-jquery.html) 17:11:03 INFO - PROCESS | 9776 | RSS: Main: 151724032 17:11:03 INFO - PROCESS | 9776 | 17:14:05 INFO - PROCESS | 9776 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38194/tests/dromaeo/cssquery-mootools.html) 17:14:06 INFO - PROCESS | 9776 | RSS: Main: 154865664 17:14:06 INFO - PROCESS | 9776 | 17:17:07 INFO - PROCESS | 9776 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38194/tests/dromaeo/cssquery-prototype.html) 17:17:08 INFO - PROCESS | 9776 | RSS: Main: 150933504 17:17:08 INFO - PROCESS | 9776 | 17:20:10 INFO - PROCESS | 9776 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38194/tests/dromaeo/cssquery-yui.html) 17:20:11 INFO - PROCESS | 9776 | RSS: Main: 153530368 17:20:11 INFO - PROCESS | 9776 | 17:23:13 INFO - PROCESS | 9776 | Cycle 1(1): loaded http://localhost:38194/tests/dromaeo/cssquery-yui.html (next: http://localhost:38194/tests/dromaeo/cssquery-dojo.html) 17:23:13 INFO - PROCESS | 9776 | RSS: Main: 154529792 17:23:13 INFO - PROCESS | 9776 | 17:23:13 INFO - PROCESS | 9776 | __start_tp_report 17:23:13 INFO - PROCESS | 9776 | _x_x_mozilla_page_load 17:23:13 INFO - PROCESS | 9776 | _x_x_mozilla_page_load_details 17:23:13 INFO - PROCESS | 9776 | |i|pagename|runs| 17:23:13 INFO - PROCESS | 9776 | |0;dojo.html;3249.837508124594;3302.8678852845887;3305.3719793239266;3349.3971085204666;3353.5472711183984;5345.412004679482;5564.08192648213;5604.187392828037;5615.270014898063;5617.7191140442965;5467.972660136694;5525.696086715229;5565.721713914299;5575.358833734122;5576.721163941807;5055.469175736532;5109.948900510994;5165.612579056567;5169.09540830355;5180.611454140954;4853.150698627744;4997.350344455234;5093.388793344804;5133.101707201244;5147.433782283946;4865.70805751656;4942.777575009133;4969.850904472872;4974.228994505857;4976.2286845539;5083.008813281412;5136.64043516954;5139.486051394831;5140.228965655144;5180.5337519623035;4942.481039490837;4952.108620448318;5032.521910418504;5080.441151473335;5112.335396398445;5296.09966305729;5300.363956325227;5318.1225097858805;5340.91988620171;5356.571474282087;5967.254093238345;5987.0420732683;6002.3697511761075;6035.396460353973;6053.606515576474;5847.649141051508;6021.548383871183;6021.548383871227;6037.1246169305205;6141.179174348115;5651.039323315046;5653.067243904751;5653.519450846724;5658.066419040853;5693.202951586781;6076.513878889678;6123.357047510036;6127;6155.907661385083;6171.074338849208;5741.88516229673;5857.677827719516;5896.587238893322;5963.075723262901;6045.667488288186;5940.910886336708;5981.6710080945095;5981.700914954235;5993.280806303272;6003.399660034049;5895.469407753323;5941.70291485424;5951.4941229995065;5965.582409231312;5966.642001479925;5857.179994800731;5967.492763115097;5983.252093488314;5983.431574000463;5985.102234664748;4534.546545345505;4545.227311357077;4562.292844609091;4574.771261436915;4607.14767767964;4057.3711074783455;4101.815418306183;4107.973006748313;4110.753354798721;4160.604742549453;5618.073017951992;5629.662220266797;5668.971655141698;5677.290338707661;5729.140628905698;5837.6497410155525;5883.558733095035;5972.641641501524;6038.396160384014;6112.663803490851;5538.556915446755;5554.50009499147;5581.888362232733;5589.664620122724;5612.859678507988;4931.778069986787;5101.311322971425;5109.846704598868;5113.054084994288;5154.484551544815;6094;6099.542534309944;6115.149072927094;6174.38256174388;6200;5969.671668058299;5978.521718262616;5985.461308482258;6049.66726830011;6054.90917636227;6192.628442293477;6193.38066193377;6218.5647004709235;6226.62640241587;6251.0623406487575;5831.7375718091935;5867.765289388377;5924.585279030426;5943;6037.426444487766;5943.227380440515;5973.104034394702;5975.551833612583;6020.729067192075;6068.726907289094;5716.9428305718075;5804.854878628068;5863.530917526502;5871.442212989759;5882.970585147047;5816;5828.795992140254;5846.766129354778;5848.035074212878;5925.348211696623;5758.654480731169;5772.682502462405;5776.162456443876;5807.274090738658;5813.3895940925595;5626.521745651666;5717.914231286451;5918.2898052234;5937.762489500372;5957.523398128226;5687.431256874445;5799.130130480462;5810.854728631818;5814.505767009851;5864.706764661664 17:23:13 INFO - PROCESS | 9776 | |1;ext.html;592.5999950033727;596.049301364324;601.8044135655912;602.4427404650697;612.249993757647;39662.801685991566;40427.978601069975;40591.99999999996;40632.796836015776;40682.796586017066;44379;45022.32466513005;45036.3244551332;45099.54900450994;45102.77448612761;8729.432586881863;8825.205731484166;8894.555272236395;8894.777630559223;8909.554522273893;8584.442011269279;8612.18184272493;8648.913510864904;8669.609867555944;8676.956615216915;8689.348298877609;8750.124987501262;8753.212210901018;8762.561871906411;8790.384673072887;8669.826603467927;8670.826583468326;8719.782005449852;8735.694250701226;8772.649094036231;8573.314134869195;8654.177853103945;8682.26200772935;8718.302535797184;8726.04013558508;39961.20077598461;40563;40693;40706.38940415896;40710.59289407098;3379.374815659111;3412.522246885438;3432.502287168347;3466.584009918801;3961;28828.711712882814;29008.41983160346;29049.273768155756;29757.702422975708;30320.696793032006;3928.116173860887;3933.7836418996944;3956.36698128301;3971.126352202511;4055.3916912463364;269473;270366;270427;271047;272477;43860.78069609631;44259.33610995838;44517.332240016425;44681.329780053326;62057.68971155115;43026.569734302255;43101.56898431038;43120;43287;43294.35058474125;14505.637359065897;14747;14870.628234294229;14905.850941490446;15093.47172848945;11526.88473115275;11699.649010529698;11739.941300293443;11753.588624398106;11768.646940591796;14409.351579178961;14421.278936053155;14446.85553144476;14485;14556.636084097981;5745.770169193269;5756.884862302814;5786.768529258867;5809.738561764731;5857.088635410257;960.3373672166183;972.6158167523788;991.4546999150439;1049.8635177426886;1119.4011204005817;28061.298467538476;28327.71672283292;28474.145775626763;28740;28907.277318066797;1017.4607458047246;1043.2436483549518;1059.8039362717768;1079.8056349857102;1128.1426116151783;13985.3706583204;14064.578062658136;14129.222892740998;16210.513684589481;16736.665266694843;387962;389381;391918;392359;393909;53146.202806957925;53215.733921330146;53382.19926701103;53601.731991339795;53771;1309.7773378525674;1317.8155058291848;1317.9341032948314;1323.5367621332648;1337.1843175662839;28979.710202897702;29477;29700.405991880474;29736.702632973393;30160.84919575388;44799.328010079225;45379.54620453753;45425.318620221384;45523.544764553255;45527.54472455233;308227;311504;312717;313020;313962;31687.683123168474;44961.32558011567;46168.30747538722;46431.76784116058;46687.29969050399;42615.74637958529;43335.13329733325;43354.56645433505;43552.34671479867;43977.34033989429;36286;36320;36420.27159456849;37026.44460333151;37154.25691486209;35700.285994280486;36539.817300913324;36568.26863462663;36602.45096323611;39511;35144.64855351516;35581;35702.46446303256;35740.82129589335;36174.09564760902;31557.842210789717;32764.180895477803;33065;33077.17307067342;33581.66418335883;27216.863915680296;27733.117363568712;27777.166684999484;27812.44375112527;27914 17:23:13 INFO - PROCESS | 9776 | |2;jquery.html;339.43484098975205;343.1626830533497;344.6777263258853;344.71560962206183;348.2651605113211;17468.301267949297;17524.73712894306;17890.73163902541;18259.452216433496;18431.262749490023;16237;16565.25456354464;16873.578160545963;17252.30990760368;17292.30830766771;4836.202026665596;4921.532454416824;4952.306677065214;4963.751812409383;4965.932324550221;4906.852794416173;4944.604431645478;4989.57588604969;4998.200287953928;5025.422076461199;4962.900741985158;5025.899482010358;5031.421386540558;5096.566791822681;5277.525022747952;5236;5236.109861323546;5242.370915490127;5264.236685680574;5271.103912334912;5129.7435128243815;5314.256004159421;5327.200919862013;5338.813141540067;5341.03861304965;19792.109355079057;19805.306814261432;19915.50211244716;20324.085416156307;20440;1993.571382152844;2162.308061420346;2180.5529866377515;2200.6368949123375;2209.281983355416;9718.222542196678;9787.217022638171;9794.804103917953;9886.258530610234;9909.20726341898;1792.2562136713248;1825.2151574822822;1832.4044685477272;1835.7613510243582;1852.703567429205;58033;59376.40623593795;60869.08696369558;64937.675311623614;65053.67473162651;9647.1317581418;9806.509674516246;10011.649592264235;10299.485025748683;10353;13547.187168769906;13550.119242249419;13584.184948903097;13585.59243222705;13598.796018059737;7773.689052437952;7777.261160189773;7806.1413244543055;7827.6477558510005;7849.686012559548;7696.576688282198;7712.267334603203;7735.762278035488;7764.495307804975;7773.261540153676;4516.932246016312;4576.222042252825;4578.587927086578;4582.243929751554;4587.8623641290815;1836.0544319675378;1859.191251805469;1871.4105056907304;1876.211990963771;1880.539267879351;418.8094417040239;420.2624394188241;439.86364227089064;445.8127586413714;447.6280201183363;10852.837207441895;11091.72270693239;11110.444477776078;11119;11277.154213434025;445.24975416422785;450.6394884092713;451.37935338909;460.1326499548375;888.0897080492417;8813.383063185644;9074.364794464323;9594.568244429018;10230.744231394126;10238.744031399274;509053;561942;562999;573524;577669;82927;85118.5744071288;86107;87510;88153;1141.594733869481;1156.8958793708607;1168.1063986050508;1171.2679575265458;1174.4949671641104;16015.599610009844;16074.196290185679;16134.435294764628;16185.190740463166;16516.42192523256;36305.27389452144;36317.45523817198;36598.26803463969;36668.81665591762;37402;47252.29121563111;49880.501194987584;50443.49556504535;52527.737361312946;53215.20177197268;9493.620255189991;9600.423974561549;9665.275104367342;9671.129598336183;9703.466309353053;14124.364403601658;17273.91363043177;17850.821491784915;17973;18083.54791130232;13871.306434678025;14283.214423206824;14634.707305854035;14679.119252844863;14740.189289589176;11743.706407339885;13931.58205253844;14329.283535822959;14408.42366305378;14445.85554144445;14962.700745985238;15017.77473337879;15035.924820375829;15169.696606067597;15174.924125379302;9649.179819715122;9812.411255324418;9865.901340986498;9904.207663387057;9968.950155249468;14280.35738391754;14334.354954026885;14380.712385752435;14414.630610092025;14574.34415451286 17:23:13 INFO - PROCESS | 9776 | |3;mootools.html;1401.866822651848;1452.7385070687276;1575.2202659683458;1741.5559032446731;1755.89464632122;6752.966235168823;7200.783976480701;7233.4574906881935;7493.587852668101;7672.539647621146;7454.180040195574;7561.168271490132;7562.584057876815;7563.584002879839;7582.128055273645;2188.890555472228;2239.7200349956256;2240.6078936186104;2242.8990695418747;2246.2587346175806;2220.855644383118;2239.428945618865;2245.5059886824874;2261.694671219389;2267.2631394796676;2190.8356873234493;2223.43302457873;2231.542533780571;2244.2033078257227;2254.9436264093365;2184.7159869217057;2202.9889850550726;2220.433789383713;2228.6322756745117;2235.1729859951843;2218.556288742242;2236.6197746383154;2241.8766967816764;2251;2258.8757618330983;7285.708571657127;7326.120865496121;7355.227701091415;7355.2644735526555;7388.9261107388775;4512.751798651106;4604.079184163181;4604.884877878047;4605.332226827125;4608.147492713859;3088.366884788613;3099.2871639523037;3216.5979252593424;3219.710226079664;3233.143217047484;1109.4563663804677;1129.24904938216;1133.0425790207262;1134.2457265918154;1141.452102990561;9653.469059201741;9735.951320243354;9786.951065244699;9816.165625921805;9819.509024548744;3878.5539662939123;3914.5106861642294;3926.8821935341984;3986.382110772835;4001.4998125234347;8098.51408915467;8122.268995790289;8129;8157.714479993172;8159.632816523271;4423.690341676116;4423.690341676116;4440.067585806952;4440.622547083534;4443.6889417741095;4098.549159592442;4129.29801933672;4145;4161.063760653889;4203.936940945889;3402.9110684580696;3415.231572896128;3426.0749597608506;3435.9828200858838;3450.551428314303;1049.0610903241557;1058.4866339825178;1059.6873922192972;1060.390275591538;1063.4788953412926;933.2673851026912;936.0826390137703;941.9293552983554;1005.5324274212526;1332.0742084251547;7070.92929070713;7095.751648692271;7112.679929403189;7116.252793456612;7122.679479423438;494.3795536601614;1181.8463599731979;1195.0678470792795;1208.7401208739986;1214.4838443661408;5697.373288938214;5717.2281741965135;5745.885082298414;5763.510101641324;5766.106253530709;8526.701565445179;8548.273396761346;8639.222469977733;8807.91192088071;8810.20708136258;8500.14998500145;8610.354223433142;8627.827443451222;8630.741077767552;8727;6957.443404527626;7025;7050.541714788523;7068.752593659197;7147.106611673541;7143.214246432992;7217.927820721936;7227.7831665050135;7231.059962204879;7260.564366137837;8007.479513831582;8050.919490805251;8230.670773169006;8266.504009759434;8357.540335281617;8166.591670416574;8307.460015098999;8370.874436883574;8395.24442800151;8411.200935911078;5914.112883067574;6341.619502829845;6507.12153859223;6563.868722625425;6648.767293144717;7181.856362872609;7207.819804504929;7261.6006119663925;7273.9636301818155;7291.744788932362;6663.633500157538;6894.482913781587;6906.274841141608;6915.377616014382;6964.0598519201285;6667.399934005769;6671.566348187353;6675.632840193836;6795.966020169867;6800.489963252875;6804.727810887509;6867.896981545381;6869.725210991504;6897.793066208022;6905.205901321412;6114.38856114385;6163.506919446344;6185.072239164161;6191.473724733448;6201.875962480635;6084.847878803065;6086.756529738938;6106.389361063858;6113.633182009094;6134.35589263121 17:23:13 INFO - PROCESS | 9776 | |4;prototype.html;319.60528746997454;321.4775989017846;324.6072252574385;329.2312450428251;329.93401319736046;6381.904271435932;6391.488680905528;6400.9039864402075;6461.289258181602;6519.543631945766;6289.842753931154;6346.460550853183;6357.904631430532;6359.364063593638;6383.904241436382;4758.643101767364;4799.856004319859;4805.0389922015565;4806.3030860525205;4814.229723244282;4799.112164249625;4799.712017278957;4803.63972702047;4805.495422980589;4819.951800481986;4683.437987441494;4755.167845627001;4772.90454190916;4775.594074503671;4780.282957556377;4766.2374020156785;4766.642501812361;4771.570558649738;4779.020300838337;4779.569838714532;4119.340905455113;4124.092699606082;4131.111810960628;4138.979305103455;4143.08852052548;6048.425399587032;6065.150878876917;6068.726907289182;6073.028315469548;6074.878502429927;5453;5571.1086226203615;5577.776888924438;5580.302462192226;5581;6715.3620406061345;6727.865442691168;6748.527603067787;6751.594904305757;6756.189257289157;4573.634109271284;4589.79345929434;4591.977040114778;4592.517785632527;4602.079584083197;6844.691988860513;6964.233934267227;7015.754448594325;7038.296170382972;7083;4566.520515345907;4605.424321959755;4606.401167848158;4611.584957353854;4611.76941152941;4663.020765639254;4666.253399456071;4666.416697912761;4668.743219122913;4673.345731597579;5482.835514934558;5483.643563168382;5486.341639003345;5490.752916118784;5490.917636235459;6629.303923088103;6787.457003439713;6792.0830687856505;6794.796156115324;6798.76204332846;1587.1429428108922;1623.7320842060928;1640.753886916972;1640.9425670101489;1642.3348543839763;1060.8037513059953;1066.6106870992032;1069.4118234970736;1077.28898926708;1077.5851297250615;6331.746730130743;6344.302126766052;6346.079818426395;6350.809475715643;6357.777477788255;6833.077534532874;6854.2117656470145;6874.725010999504;6886.001529778154;6903;6204;6342.080398342215;6344.619322840552;6350.206224221973;6355.205599300088;3740.831662575191;3756.6243375662216;3759.6052414496085;3767.566729826105;3767.660910518012;7122.2521635228595;7128.358447739728;7129;7132.215456299803;7134.500584959003;7011.92988070123;7039.894401583981;7044.718211271595;7057.294270572902;7064.752733654297;7370.484066115428;7385.66764495599;7403.8149046274275;7404.666789994463;7408.888866667005;7042.119735033121;7061.576305421691;7078.398336141486;7082.3979961703835;7092.858142837011;6894;6977.302269773185;6985.196702379291;6985.825354366181;7032.578045317297;7311.4516411268305;7340.412766978736;7369.926300736924;7380.5940673263485;7383.593902335423;4699.459562150397;4724.834630788044;4725.125851717443;4729.030548737569;4743.976280118577;6870.587764734132;6904.93095069063;7012.2286548478605;7056.823579410556;7102.644867756695;6795.966020169867;6825.215100263533;6850.862982740217;6857.657117144223;6891.655417229219;6803.795886123424;6831.9316806833285;6832.863342733217;6845.965770171118;6878.759243426456;6540.705668244846;6726.562773419712;6728.596284222962;6730.966345168439;6739.764108256188;6886.965565172142;6903.1716194057035;6911.75808846688;6911.75808846688;6935.653217339012;6669.599824010575;6678.298778628368;6711.530192886451;6741.797746067626;6743.561668491532 17:23:13 INFO - PROCESS | 9776 | |5;yui.html;757.9848403031936;761.649641165064;813.9715109971148;842.7162389923308;882.7837179890926;13529.864701352995;13608.455661773518;13662.931685341584;13668.316584170776;13768.38042288097;12559.120861539695;12750.68123296918;14621.92689036556;14737.115773053625;14760.926195369007;821.6384790692106;824.3240542754943;824.8020475085996;825.7275099217273;826.1903334731982;828.2628460670009;844.0040751912741;844.4426678392263;844.5144042175742;846.9110743371949;859.4800145911727;869.1091631078132;870.7431307764193;873.4846440600045;875.5097145598453;865.9610317535695;868.5266529741306;869.3219288954593;871.4422769427572;875.0767939823547;636.1697984130708;637.6970938804031;638.3201889987196;638.3297537585563;639.2041907824741;13508.729825403438;13634.454621815115;13646.86353136466;13730.176189428666;13737.313134343243;11377.089832813355;11472.942635286854;11711.180217384786;11937.880621193764;12345.938270308681;9050.597157440607;9236.353455258135;9791.755206119833;10380.11768999636;10450.84323735137;3623.076115590534;3658.902329301199;3673.412254039368;3720.776753394778;3800.448934904451;44093.77953110214;44482.55517444816;45042.54957450416;45127.54872451299;45135.54864451346;9355.158035776813;9914.157296629723;9933.701988940198;9956.601735930626;10329.586816527404;17389.217485213198;17405.912970435067;17461.563460913323;17487.912560437115;17599.384021559184;7511.474196806281;7670.117936437381;7791.961040194763;7792.493487923267;7793.532388056735;4393.560643935581;4472.508024117345;4537.342085397599;4580.083983203306;4595.126925884071;3070.1557071805432;3098.1170366445454;3102.488089465213;3103.472409690358;3111.9377612447624;558.1460365640577;570.0565563991518;574.5949105880344;577.1170109732117;580.5964854426218;656.6486929492698;676.4723515657795;692.2489099327287;702.8840241360118;704.6969802984663;8283;9050.728478145666;9058.682946096855;9268.582913768896;9477.194438472668;695.2664938489942;709.1667290933133;713.3187805645596;722.9024081749002;725.4341613541446;3987.6211759882763;4225.619694227473;4235.745855248695;4338.717983331074;4382.6055654991205;63242;64764;64958.72644457421;65094;65141.348586514476;51497;51582.48417515852;51834.74082629563;51844.740776295876;52475;47013;47130.76434617874;47605;49049;49575;8409.53747543891;8534.74395768128;8608.48349099056;8914.108589141035;8982.86525702128;36606;37156.62843371532;37473.81263093667;38215.61784382232;38417.61582384141;45956.77021615004;46221.53778462172;46232;46419.53580464152;46762.532374677176;10705.732356691145;10767.784644307227;11056;11061.944690276498;11264.549418023187;12518.186317889673;12557.87442125567;12561.560345387868;12703.36483175856;13073.869261307265;11311.604093857004;11794.52821887115;11825.172237943261;11942.223755455867;12207;11812.70468238301;11968.222065565711;12039.578614748441;12068.939655301667;12487.812682809583;11185.217034807485;11260.662180134608;11543.191976561897;11918.582849600223;12050.337231452355;9705.417674939526;9739.366941148803;9747.999107961557;9755.268354873555;9789.265805064506;8356.247937685637;9191.724248272563;9987.650432234837;10005.399676019462;10033.799324013333 17:23:13 INFO - PROCESS | 9776 | __end_tp_report 17:23:13 INFO - PROCESS | 9776 | __start_cc_report 17:23:13 INFO - PROCESS | 9776 | _x_x_mozilla_cycle_collect,299 17:23:13 INFO - PROCESS | 9776 | __end_cc_report 17:23:13 INFO - PROCESS | 9776 | __startTimestamp1450920193970__endTimestamp 17:23:13 INFO - PROCESS | 9776 | 17:23:13 INFO - PROCESS | 9776 | ------- Summary: start ------- 17:23:13 INFO - PROCESS | 9776 | Number of tests: 6 17:23:13 INFO - PROCESS | 9776 | 17:23:13 INFO - PROCESS | 9776 | [#0] dojo.html Cycles:165 Average:5543.76 Median:5776.16 stddev:629.02 (10.9%) stddev-sans-first:604.66 17:23:13 INFO - PROCESS | 9776 | Values: 3249.8 3302.9 3305.4 3349.4 3353.5 5345.4 5564.1 5604.2 5615.3 5617.7 5468.0 5525.7 5565.7 5575.4 5576.7 5055.5 5109.9 5165.6 5169.1 5180.6 4853.2 4997.4 5093.4 5133.1 5147.4 4865.7 4942.8 4969.9 4974.2 4976.2 5083.0 5136.6 5139.5 5140.2 5180.5 4942.5 4952.1 5032.5 5080.4 5112.3 5296.1 5300.4 5318.1 5340.9 5356.6 5967.3 5987.0 6002.4 6035.4 6053.6 5847.6 6021.5 6021.5 6037.1 6141.2 5651.0 5653.1 5653.5 5658.1 5693.2 6076.5 6123.4 6127.0 6155.9 6171.1 5741.9 5857.7 5896.6 5963.1 6045.7 5940.9 5981.7 5981.7 5993.3 6003.4 5895.5 5941.7 5951.5 5965.6 5966.6 5857.2 5967.5 5983.3 5983.4 5985.1 4534.5 4545.2 4562.3 4574.8 4607.1 4057.4 4101.8 4108.0 4110.8 4160.6 5618.1 5629.7 5669.0 5677.3 5729.1 5837.6 5883.6 5972.6 6038.4 6112.7 5538.6 5554.5 5581.9 5589.7 5612.9 4931.8 5101.3 5109.8 5113.1 5154.5 6094.0 6099.5 6115.1 6174.4 6200.0 5969.7 5978.5 5985.5 6049.7 6054.9 6192.6 6193.4 6218.6 6226.6 6251.1 5831.7 5867.8 5924.6 5943.0 6037.4 5943.2 5973.1 5975.6 6020.7 6068.7 5716.9 5804.9 5863.5 5871.4 5883.0 5816.0 5828.8 5846.8 5848.0 5925.3 5758.7 5772.7 5776.2 5807.3 5813.4 5626.5 5717.9 5918.3 5937.8 5957.5 5687.4 5799.1 5810.9 5814.5 5864.7 17:23:13 INFO - PROCESS | 9776 | 17:23:13 INFO - PROCESS | 9776 | [#1] ext.html Cycles:180 Average:48616.28 Median:3930.95 stddev:86243.45 (2194.0%) stddev-sans-first:86410.01 17:23:13 INFO - PROCESS | 9776 | Values: 592.6 596.0 601.8 602.4 612.2 39662.8 40428.0 40592.0 40632.8 40682.8 44379.0 45022.3 45036.3 45099.5 45102.8 8729.4 8825.2 8894.6 8894.8 8909.6 8584.4 8612.2 8648.9 8669.6 8677.0 8689.3 8750.1 8753.2 8762.6 8790.4 8669.8 8670.8 8719.8 8735.7 8772.6 8573.3 8654.2 8682.3 8718.3 8726.0 39961.2 40563.0 40693.0 40706.4 40710.6 3379.4 3412.5 3432.5 3466.6 3961.0 28828.7 29008.4 29049.3 29757.7 30320.7 3928.1 3933.8 3956.4 3971.1 4055.4 269473.0 270366.0 270427.0 271047.0 272477.0 43860.8 44259.3 44517.3 44681.3 62057.7 43026.6 43101.6 43120.0 43287.0 43294.4 14505.6 14747.0 14870.6 14905.9 15093.5 11526.9 11699.6 11739.9 11753.6 11768.6 14409.4 14421.3 14446.9 14485.0 14556.6 5745.8 5756.9 5786.8 5809.7 5857.1 960.3 972.6 991.5 1049.9 1119.4 28061.3 28327.7 28474.1 28740.0 28907.3 1017.5 1043.2 1059.8 1079.8 1128.1 13985.4 14064.6 14129.2 16210.5 16736.7 387962.0 389381.0 391918.0 392359.0 393909.0 53146.2 53215.7 53382.2 53601.7 53771.0 1309.8 1317.8 1317.9 1323.5 1337.2 28979.7 29477.0 29700.4 29736.7 30160.8 44799.3 45379.5 45425.3 45523.5 45527.5 308227.0 311504.0 312717.0 313020.0 313962.0 31687.7 44961.3 46168.3 46431.8 46687.3 42615.7 43335.1 43354.6 43552.3 43977.3 36286.0 36320.0 36420.3 37026.4 37154.3 35700.3 36539.8 36568.3 36602.5 39511.0 35144.6 35581.0 35702.5 35740.8 36174.1 31557.8 32764.2 33065.0 33077.2 33581.7 27216.9 27733.1 27777.2 27812.4 27914.0 17:23:13 INFO - PROCESS | 9776 | 17:23:13 INFO - PROCESS | 9776 | [#2] jquery.html Cycles:180 Average:29589.91 Median:419.54 stddev:91231.20 (21745.7%) stddev-sans-first:91460.69 17:23:13 INFO - PROCESS | 9776 | Values: 339.4 343.2 344.7 344.7 348.3 17468.3 17524.7 17890.7 18259.5 18431.3 16237.0 16565.3 16873.6 17252.3 17292.3 4836.2 4921.5 4952.3 4963.8 4965.9 4906.9 4944.6 4989.6 4998.2 5025.4 4962.9 5025.9 5031.4 5096.6 5277.5 5236.0 5236.1 5242.4 5264.2 5271.1 5129.7 5314.3 5327.2 5338.8 5341.0 19792.1 19805.3 19915.5 20324.1 20440.0 1993.6 2162.3 2180.6 2200.6 2209.3 9718.2 9787.2 9794.8 9886.3 9909.2 1792.3 1825.2 1832.4 1835.8 1852.7 58033.0 59376.4 60869.1 64937.7 65053.7 9647.1 9806.5 10011.6 10299.5 10353.0 13547.2 13550.1 13584.2 13585.6 13598.8 7773.7 7777.3 7806.1 7827.6 7849.7 7696.6 7712.3 7735.8 7764.5 7773.3 4516.9 4576.2 4578.6 4582.2 4587.9 1836.1 1859.2 1871.4 1876.2 1880.5 418.8 420.3 439.9 445.8 447.6 10852.8 11091.7 11110.4 11119.0 11277.2 445.2 450.6 451.4 460.1 888.1 8813.4 9074.4 9594.6 10230.7 10238.7 509053.0 561942.0 562999.0 573524.0 577669.0 82927.0 85118.6 86107.0 87510.0 88153.0 1141.6 1156.9 1168.1 1171.3 1174.5 16015.6 16074.2 16134.4 16185.2 16516.4 36305.3 36317.5 36598.3 36668.8 37402.0 47252.3 49880.5 50443.5 52527.7 53215.2 9493.6 9600.4 9665.3 9671.1 9703.5 14124.4 17273.9 17850.8 17973.0 18083.5 13871.3 14283.2 14634.7 14679.1 14740.2 11743.7 13931.6 14329.3 14408.4 14445.9 14962.7 15017.8 15035.9 15169.7 15174.9 9649.2 9812.4 9865.9 9904.2 9969.0 14280.4 14334.4 14380.7 14414.6 14574.3 17:23:13 INFO - PROCESS | 9776 | 17:23:13 INFO - PROCESS | 9776 | [#3] mootools.html Cycles:180 Average:5224.11 Median:6188.27 stddev:2639.82 (42.7%) stddev-sans-first:2631.59 17:23:13 INFO - PROCESS | 9776 | Values: 1401.9 1452.7 1575.2 1741.6 1755.9 6753.0 7200.8 7233.5 7493.6 7672.5 7454.2 7561.2 7562.6 7563.6 7582.1 2188.9 2239.7 2240.6 2242.9 2246.3 2220.9 2239.4 2245.5 2261.7 2267.3 2190.8 2223.4 2231.5 2244.2 2254.9 2184.7 2203.0 2220.4 2228.6 2235.2 2218.6 2236.6 2241.9 2251.0 2258.9 7285.7 7326.1 7355.2 7355.3 7388.9 4512.8 4604.1 4604.9 4605.3 4608.1 3088.4 3099.3 3216.6 3219.7 3233.1 1109.5 1129.2 1133.0 1134.2 1141.5 9653.5 9736.0 9787.0 9816.2 9819.5 3878.6 3914.5 3926.9 3986.4 4001.5 8098.5 8122.3 8129.0 8157.7 8159.6 4423.7 4423.7 4440.1 4440.6 4443.7 4098.5 4129.3 4145.0 4161.1 4203.9 3402.9 3415.2 3426.1 3436.0 3450.6 1049.1 1058.5 1059.7 1060.4 1063.5 933.3 936.1 941.9 1005.5 1332.1 7070.9 7095.8 7112.7 7116.3 7122.7 494.4 1181.8 1195.1 1208.7 1214.5 5697.4 5717.2 5745.9 5763.5 5766.1 8526.7 8548.3 8639.2 8807.9 8810.2 8500.1 8610.4 8627.8 8630.7 8727.0 6957.4 7025.0 7050.5 7068.8 7147.1 7143.2 7217.9 7227.8 7231.1 7260.6 8007.5 8050.9 8230.7 8266.5 8357.5 8166.6 8307.5 8370.9 8395.2 8411.2 5914.1 6341.6 6507.1 6563.9 6648.8 7181.9 7207.8 7261.6 7274.0 7291.7 6663.6 6894.5 6906.3 6915.4 6964.1 6667.4 6671.6 6675.6 6796.0 6800.5 6804.7 6867.9 6869.7 6897.8 6905.2 6114.4 6163.5 6185.1 6191.5 6201.9 6084.8 6086.8 6106.4 6113.6 6134.4 17:23:13 INFO - PROCESS | 9776 | 17:23:13 INFO - PROCESS | 9776 | [#4] prototype.html Cycles:180 Average:5624.67 Median:6356.49 stddev:1742.65 (27.4%) stddev-sans-first:1701.44 17:23:13 INFO - PROCESS | 9776 | Values: 319.6 321.5 324.6 329.2 329.9 6381.9 6391.5 6400.9 6461.3 6519.5 6289.8 6346.5 6357.9 6359.4 6383.9 4758.6 4799.9 4805.0 4806.3 4814.2 4799.1 4799.7 4803.6 4805.5 4820.0 4683.4 4755.2 4772.9 4775.6 4780.3 4766.2 4766.6 4771.6 4779.0 4779.6 4119.3 4124.1 4131.1 4139.0 4143.1 6048.4 6065.2 6068.7 6073.0 6074.9 5453.0 5571.1 5577.8 5580.3 5581.0 6715.4 6727.9 6748.5 6751.6 6756.2 4573.6 4589.8 4592.0 4592.5 4602.1 6844.7 6964.2 7015.8 7038.3 7083.0 4566.5 4605.4 4606.4 4611.6 4611.8 4663.0 4666.3 4666.4 4668.7 4673.3 5482.8 5483.6 5486.3 5490.8 5490.9 6629.3 6787.5 6792.1 6794.8 6798.8 1587.1 1623.7 1640.8 1640.9 1642.3 1060.8 1066.6 1069.4 1077.3 1077.6 6331.7 6344.3 6346.1 6350.8 6357.8 6833.1 6854.2 6874.7 6886.0 6903.0 6204.0 6342.1 6344.6 6350.2 6355.2 3740.8 3756.6 3759.6 3767.6 3767.7 7122.3 7128.4 7129.0 7132.2 7134.5 7011.9 7039.9 7044.7 7057.3 7064.8 7370.5 7385.7 7403.8 7404.7 7408.9 7042.1 7061.6 7078.4 7082.4 7092.9 6894.0 6977.3 6985.2 6985.8 7032.6 7311.5 7340.4 7369.9 7380.6 7383.6 4699.5 4724.8 4725.1 4729.0 4744.0 6870.6 6904.9 7012.2 7056.8 7102.6 6796.0 6825.2 6850.9 6857.7 6891.7 6803.8 6831.9 6832.9 6846.0 6878.8 6540.7 6726.6 6728.6 6731.0 6739.8 6887.0 6903.2 6911.8 6911.8 6935.7 6669.6 6678.3 6711.5 6741.8 6743.6 17:23:13 INFO - PROCESS | 9776 | 17:23:13 INFO - PROCESS | 9776 | [#5] yui.html Cycles:180 Average:14153.67 Median:47071.88 stddev:16634.13 (35.3%) stddev-sans-first:16650.37 17:23:13 INFO - PROCESS | 9776 | Values: 758.0 761.6 814.0 842.7 882.8 13529.9 13608.5 13662.9 13668.3 13768.4 12559.1 12750.7 14621.9 14737.1 14760.9 821.6 824.3 824.8 825.7 826.2 828.3 844.0 844.4 844.5 846.9 859.5 869.1 870.7 873.5 875.5 866.0 868.5 869.3 871.4 875.1 636.2 637.7 638.3 638.3 639.2 13508.7 13634.5 13646.9 13730.2 13737.3 11377.1 11472.9 11711.2 11937.9 12345.9 9050.6 9236.4 9791.8 10380.1 10450.8 3623.1 3658.9 3673.4 3720.8 3800.4 44093.8 44482.6 45042.5 45127.5 45135.5 9355.2 9914.2 9933.7 9956.6 10329.6 17389.2 17405.9 17461.6 17487.9 17599.4 7511.5 7670.1 7792.0 7792.5 7793.5 4393.6 4472.5 4537.3 4580.1 4595.1 3070.2 3098.1 3102.5 3103.5 3111.9 558.1 570.1 574.6 577.1 580.6 656.6 676.5 692.2 702.9 704.7 8283.0 9050.7 9058.7 9268.6 9477.2 695.3 709.2 713.3 722.9 725.4 3987.6 4225.6 4235.7 4338.7 4382.6 63242.0 64764.0 64958.7 65094.0 65141.3 51497.0 51582.5 51834.7 51844.7 52475.0 47013.0 47130.8 47605.0 49049.0 49575.0 8409.5 8534.7 8608.5 8914.1 8982.9 36606.0 37156.6 37473.8 38215.6 38417.6 45956.8 46221.5 46232.0 46419.5 46762.5 10705.7 10767.8 11056.0 11061.9 11264.5 12518.2 12557.9 12561.6 12703.4 13073.9 11311.6 11794.5 11825.2 11942.2 12207.0 11812.7 11968.2 12039.6 12068.9 12487.8 11185.2 11260.7 11543.2 11918.6 12050.3 9705.4 9739.4 9748.0 9755.3 9789.3 8356.2 9191.7 9987.7 10005.4 10033.8 17:23:13 INFO - PROCESS | 9776 | -------- Summary: end -------- 17:23:13 INFO - PROCESS | 9776 | 17:23:14 INFO - TEST-INFO | 9776: exit 0 17:23:14 INFO - TEST-OK | dromaeo_css | took 1110825ms 17:23:14 INFO - TEST-START | kraken 17:23:14 INFO - operating with platform_type : linux_ 17:23:14 INFO - Initialising browser for kraken test... 17:23:14 INFO - TEST-INFO | started process 10023 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVmel6t/profile http://localhost:38194/getInfo.html) 17:23:19 INFO - PROCESS | 10023 | __metrics Screen width/height:1600/1200 17:23:19 INFO - PROCESS | 10023 | colorDepth:24 17:23:19 INFO - PROCESS | 10023 | Browser inner width/height: 1024/697 17:23:19 INFO - PROCESS | 10023 | __metrics 17:23:19 INFO - PROCESS | 10023 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:23:20 INFO - TEST-INFO | 10023: exit 0 17:23:20 INFO - Browser initialized. 17:23:20 INFO - Running cycle 1/1 for kraken test... 17:23:20 INFO - TEST-INFO | started process 10144 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVmel6t/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:31 INFO - PROCESS | 10144 | RSS: Main: 149557248 17:23:31 INFO - PROCESS | 10144 | 17:23:34 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38194/tests/kraken/driver.html?testName=audio-beat-detection) 17:23:34 INFO - PROCESS | 10144 | RSS: Main: 150032384 17:23:34 INFO - PROCESS | 10144 | 17:23:37 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38194/tests/kraken/driver.html?testName=audio-dft) 17:23:38 INFO - PROCESS | 10144 | RSS: Main: 150695936 17:23:38 INFO - PROCESS | 10144 | 17:23:41 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38194/tests/kraken/driver.html?testName=audio-fft) 17:23:41 INFO - PROCESS | 10144 | RSS: Main: 144605184 17:23:41 INFO - PROCESS | 10144 | 17:23:43 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38194/tests/kraken/driver.html?testName=audio-oscillator) 17:23:44 INFO - PROCESS | 10144 | RSS: Main: 145039360 17:23:44 INFO - PROCESS | 10144 | 17:23:46 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38194/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:23:46 INFO - PROCESS | 10144 | RSS: Main: 145735680 17:23:46 INFO - PROCESS | 10144 | 17:23:49 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38194/tests/kraken/driver.html?testName=imaging-darkroom) 17:23:50 INFO - PROCESS | 10144 | RSS: Main: 146231296 17:23:50 INFO - PROCESS | 10144 | 17:23:53 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38194/tests/kraken/driver.html?testName=imaging-desaturate) 17:23:54 INFO - PROCESS | 10144 | RSS: Main: 147468288 17:23:54 INFO - PROCESS | 10144 | 17:23:57 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38194/tests/kraken/driver.html?testName=json-parse-financial) 17:23:57 INFO - PROCESS | 10144 | RSS: Main: 147562496 17:23:57 INFO - PROCESS | 10144 | 17:23:59 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38194/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:00 INFO - PROCESS | 10144 | RSS: Main: 148299776 17:24:00 INFO - PROCESS | 10144 | 17:24:01 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:02 INFO - PROCESS | 10144 | RSS: Main: 147963904 17:24:02 INFO - PROCESS | 10144 | 17:24:04 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:05 INFO - PROCESS | 10144 | RSS: Main: 147312640 17:24:05 INFO - PROCESS | 10144 | 17:24:07 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:08 INFO - PROCESS | 10144 | RSS: Main: 147062784 17:24:08 INFO - PROCESS | 10144 | 17:24:10 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:11 INFO - PROCESS | 10144 | RSS: Main: 148934656 17:24:11 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | Cycle 1(1): loaded http://localhost:38194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38194/tests/kraken/driver.html?testName=ai-astar) 17:24:13 INFO - PROCESS | 10144 | RSS: Main: 148639744 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | __start_tp_report 17:24:13 INFO - PROCESS | 10144 | _x_x_mozilla_page_load 17:24:13 INFO - PROCESS | 10144 | _x_x_mozilla_page_load_details 17:24:13 INFO - PROCESS | 10144 | |i|pagename|runs| 17:24:13 INFO - PROCESS | 10144 | |0;ai-astar;112;107;112;110;111;122;109;110;111;112 17:24:13 INFO - PROCESS | 10144 | |1;audio-beat-detection;152;123;153;167;127;153;161;131;161;128 17:24:13 INFO - PROCESS | 10144 | |2;audio-dft;164;162;163;162;162;162;162;164;175;164 17:24:13 INFO - PROCESS | 10144 | |3;audio-fft;71;70;73;75;72;147;74;72;71;72 17:24:13 INFO - PROCESS | 10144 | |4;audio-oscillator;93;93;135;93;93;93;140;94;93;137 17:24:13 INFO - PROCESS | 10144 | |5;imaging-gaussian-blur;110;110;110;109;109;109;112;110;112;110 17:24:13 INFO - PROCESS | 10144 | |6;imaging-darkroom;146;147;147;146;146;146;146;148;147;147 17:24:13 INFO - PROCESS | 10144 | |7;imaging-desaturate;97;96;97;96;96;97;96;96;97;96 17:24:13 INFO - PROCESS | 10144 | |8;json-parse-financial;60;58;59;60;62;60;58;59;58;59 17:24:13 INFO - PROCESS | 10144 | |9;json-stringify-tinderbox;68;69;68;68;70;70;69;70;70;68 17:24:13 INFO - PROCESS | 10144 | |10;stanford-crypto-aes;84;92;86;86;85;85;85;85;85;84 17:24:13 INFO - PROCESS | 10144 | |11;stanford-crypto-ccm;121;116;130;116;125;131;121;119;132;120 17:24:13 INFO - PROCESS | 10144 | |12;stanford-crypto-pbkdf2;144;150;151;149;154;150;151;148;162;139 17:24:13 INFO - PROCESS | 10144 | |13;stanford-crypto-sha256-iterative;68;66;66;66;67;66;65;66;65;66 17:24:13 INFO - PROCESS | 10144 | __end_tp_report 17:24:13 INFO - PROCESS | 10144 | __start_cc_report 17:24:13 INFO - PROCESS | 10144 | _x_x_mozilla_cycle_collect,755 17:24:13 INFO - PROCESS | 10144 | __end_cc_report 17:24:13 INFO - PROCESS | 10144 | __startTimestamp1450920253255__endTimestamp 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | ------- Summary: start ------- 17:24:13 INFO - PROCESS | 10144 | Number of tests: 14 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:3.98 (3.6%) stddev-sans-first:4.22 17:24:13 INFO - PROCESS | 10144 | Values: 112.0 107.0 112.0 110.0 111.0 122.0 109.0 110.0 111.0 112.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:153.00 stddev:16.54 (10.8%) stddev-sans-first:17.38 17:24:13 INFO - PROCESS | 10144 | Values: 152.0 123.0 153.0 167.0 127.0 153.0 161.0 131.0 161.0 128.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.97 (2.4%) stddev-sans-first:4.21 17:24:13 INFO - PROCESS | 10144 | Values: 164.0 162.0 163.0 162.0 162.0 162.0 162.0 164.0 175.0 164.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#3] audio-fft Cycles:10 Average:79.70 Median:72.00 stddev:23.69 (32.9%) stddev-sans-first:24.92 17:24:13 INFO - PROCESS | 10144 | Values: 71.0 70.0 73.0 75.0 72.0 147.0 74.0 72.0 71.0 72.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:93.00 stddev:21.38 (23.0%) stddev-sans-first:22.12 17:24:13 INFO - PROCESS | 10144 | Values: 93.0 93.0 135.0 93.0 93.0 93.0 140.0 94.0 93.0 137.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 17:24:13 INFO - PROCESS | 10144 | Values: 110.0 110.0 110.0 109.0 109.0 109.0 112.0 110.0 112.0 110.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 17:24:13 INFO - PROCESS | 10144 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 146.0 148.0 147.0 147.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:24:13 INFO - PROCESS | 10144 | Values: 97.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.50 stddev:1.25 (2.1%) stddev-sans-first:1.30 17:24:13 INFO - PROCESS | 10144 | Values: 60.0 58.0 59.0 60.0 62.0 60.0 58.0 59.0 58.0 59.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.50 stddev:0.94 (1.4%) stddev-sans-first:0.93 17:24:13 INFO - PROCESS | 10144 | Values: 68.0 69.0 68.0 68.0 70.0 70.0 69.0 70.0 70.0 68.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.31 (2.7%) stddev-sans-first:2.37 17:24:13 INFO - PROCESS | 10144 | Values: 84.0 92.0 86.0 86.0 85.0 85.0 85.0 85.0 85.0 84.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:123.00 stddev:6.05 (4.9%) stddev-sans-first:6.36 17:24:13 INFO - PROCESS | 10144 | Values: 121.0 116.0 130.0 116.0 125.0 131.0 121.0 119.0 132.0 120.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:150.50 stddev:6.00 (4.0%) stddev-sans-first:5.98 17:24:13 INFO - PROCESS | 10144 | Values: 144.0 150.0 151.0 149.0 154.0 150.0 151.0 148.0 162.0 139.0 17:24:13 INFO - PROCESS | 10144 | 17:24:13 INFO - PROCESS | 10144 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.60 17:24:13 INFO - PROCESS | 10144 | Values: 68.0 66.0 66.0 66.0 67.0 66.0 65.0 66.0 65.0 66.0 17:24:13 INFO - PROCESS | 10144 | -------- Summary: end -------- 17:24:13 INFO - PROCESS | 10144 | 17:24:14 INFO - TEST-INFO | 10144: exit 0 17:24:14 INFO - TEST-OK | kraken | took 59505ms 17:24:14 INFO - TEST-START | v8_7 17:24:14 INFO - operating with platform_type : linux_ 17:24:14 INFO - Initialising browser for v8_7 test... 17:24:14 INFO - TEST-INFO | started process 10429 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaxSmQo/profile http://localhost:38194/getInfo.html) 17:24:18 INFO - PROCESS | 10429 | __metrics Screen width/height:1600/1200 17:24:18 INFO - PROCESS | 10429 | colorDepth:24 17:24:18 INFO - PROCESS | 10429 | Browser inner width/height: 1024/697 17:24:18 INFO - PROCESS | 10429 | __metrics 17:24:18 INFO - PROCESS | 10429 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:24:19 INFO - TEST-INFO | 10429: exit 0 17:24:19 INFO - Browser initialized. 17:24:19 INFO - Running cycle 1/1 for v8_7 test... 17:24:19 INFO - TEST-INFO | started process 10550 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaxSmQo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:31 INFO - PROCESS | 10550 | RSS: Main: 149499904 17:24:31 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | Cycle 1(1): loaded http://localhost:38194/tests/v8_7/run.html (next: http://localhost:38194/tests/v8_7/run.html) 17:24:52 INFO - PROCESS | 10550 | RSS: Main: 145625088 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | __start_tp_report 17:24:52 INFO - PROCESS | 10550 | _x_x_mozilla_page_load 17:24:52 INFO - PROCESS | 10550 | _x_x_mozilla_page_load_details 17:24:52 INFO - PROCESS | 10550 | |i|pagename|runs| 17:24:52 INFO - PROCESS | 10550 | |0;Richards;165.97510373443984 17:24:52 INFO - PROCESS | 10550 | |1;DeltaBlue;194.51468585878234 17:24:52 INFO - PROCESS | 10550 | |2;Encrypt;284.1716396703609 17:24:52 INFO - PROCESS | 10550 | |3;Decrypt;5191.709844559586 17:24:52 INFO - PROCESS | 10550 | |4;RayTrace;1086.9565217391305 17:24:52 INFO - PROCESS | 10550 | |5;Earley;756.4296520423601 17:24:52 INFO - PROCESS | 10550 | |6;Boyer;11976.190476190477 17:24:52 INFO - PROCESS | 10550 | |7;RegExp;24829.268292682926 17:24:52 INFO - PROCESS | 10550 | |8;Splay;639.7952655150352 17:24:52 INFO - PROCESS | 10550 | |9;NavierStokes;4840.579710144928 17:24:52 INFO - PROCESS | 10550 | __end_tp_report 17:24:52 INFO - PROCESS | 10550 | __startTimestamp1450920292964__endTimestamp 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | ------- Summary: start ------- 17:24:52 INFO - PROCESS | 10550 | Number of tests: 10 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 17:24:52 INFO - PROCESS | 10550 | Values: 166.0 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | [#1] DeltaBlue Cycles:1 Average:194.51 Median:194.51 stddev:0.00 (0.0%) 17:24:52 INFO - PROCESS | 10550 | Values: 194.5 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | [#2] Encrypt Cycles:1 Average:284.17 Median:284.17 stddev:0.00 (0.0%) 17:24:52 INFO - PROCESS | 10550 | Values: 284.2 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 17:24:52 INFO - PROCESS | 10550 | Values: 5191.7 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | [#4] RayTrace Cycles:1 Average:1086.96 Median:1086.96 stddev:0.00 (0.0%) 17:24:52 INFO - PROCESS | 10550 | Values: 1087.0 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | [#5] Earley Cycles:1 Average:756.43 Median:756.43 stddev:0.00 (0.0%) 17:24:52 INFO - PROCESS | 10550 | Values: 756.4 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | [#6] Boyer Cycles:1 Average:11976.19 Median:11976.19 stddev:0.00 (0.0%) 17:24:52 INFO - PROCESS | 10550 | Values: 11976.2 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | [#7] RegExp Cycles:1 Average:24829.27 Median:24829.27 stddev:0.00 (0.0%) 17:24:52 INFO - PROCESS | 10550 | Values: 24829.3 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | [#8] Splay Cycles:1 Average:639.80 Median:639.80 stddev:0.00 (0.0%) 17:24:52 INFO - PROCESS | 10550 | Values: 639.8 17:24:52 INFO - PROCESS | 10550 | 17:24:52 INFO - PROCESS | 10550 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 17:24:52 INFO - PROCESS | 10550 | Values: 4840.6 17:24:52 INFO - PROCESS | 10550 | -------- Summary: end -------- 17:24:52 INFO - PROCESS | 10550 | 17:24:53 INFO - TEST-INFO | 10550: exit 0 17:24:53 INFO - TEST-OK | v8_7 | took 39626ms 17:24:53 INFO - SUITE-END | took 1209s 17:24:53 INFO - Completed test suite (00:20:10) 17:24:53 INFO - Working with test: dromaeo_css 17:24:53 INFO - Generating results file: dromaeo_css 17:24:53 INFO - Working with test: kraken 17:24:53 INFO - Generating results file: kraken 17:24:53 INFO - javascript benchmark 17:24:53 INFO - Working with test: v8_7 17:24:53 INFO - Generating results file: v8_7 17:24:53 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:24:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:24:54 INFO - process_Request line: dromaeo_css 7038.33 graph.html#tests=[[72,64,43]] 17:24:54 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:24:54 INFO - process_Request line: kraken 1513.40 graph.html#tests=[[232,64,43]] 17:24:54 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:24:54 INFO - process_Request line: v8_7 21072.57 graph.html#tests=[[230,64,43]] 17:24:54 INFO - RETURN: dromaeo_css: 7038.33 17:24:54 INFO - RETURN: kraken: 1513.40 17:24:54 INFO - RETURN: v8_7: 21072.57 17:24:54 INFO - javascript benchmark 17:24:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3249.837508124594, 3302.8678852845887, 3305.3719793239266, 3349.3971085204666, 3353.5472711183984, 5345.412004679482, 5564.08192648213, 5604.187392828037, 5615.270014898063, 5617.7191140442965, 5467.972660136694, 5525.696086715229, 5565.721713914299, 5575.358833734122, 5576.721163941807, 5055.469175736532, 5109.948900510994, 5165.612579056567, 5169.09540830355, 5180.611454140954, 4853.150698627744, 4997.350344455234, 5093.388793344804, 5133.101707201244, 5147.433782283946, 4865.70805751656, 4942.777575009133, 4969.850904472872, 4974.228994505857, 4976.2286845539, 5083.008813281412, 5136.64043516954, 5139.486051394831, 5140.228965655144, 5180.5337519623035, 4942.481039490837, 4952.108620448318, 5032.521910418504, 5080.441151473335, 5112.335396398445, 5296.09966305729, 5300.363956325227, 5318.1225097858805, 5340.91988620171, 5356.571474282087, 5967.254093238345, 5987.0420732683, 6002.3697511761075, 6035.396460353973, 6053.606515576474, 5847.649141051508, 6021.548383871183, 6021.548383871227, 6037.1246169305205, 6141.179174348115, 5651.039323315046, 5653.067243904751, 5653.519450846724, 5658.066419040853, 5693.202951586781, 6076.513878889678, 6123.357047510036, 6127.0, 6155.907661385083, 6171.074338849208, 5741.88516229673, 5857.677827719516, 5896.587238893322, 5963.075723262901, 6045.667488288186, 5940.910886336708, 5981.6710080945095, 5981.700914954235, 5993.280806303272, 6003.399660034049, 5895.469407753323, 5941.70291485424, 5951.4941229995065, 5965.582409231312, 5966.642001479925, 5857.179994800731, 5967.492763115097, 5983.252093488314, 5983.431574000463, 5985.102234664748, 4534.546545345505, 4545.227311357077, 4562.292844609091, 4574.771261436915, 4607.14767767964, 4057.3711074783455, 4101.815418306183, 4107.973006748313, 4110.753354798721, 4160.604742549453, 5618.073017951992, 5629.662220266797, 5668.971655141698, 5677.290338707661, 5729.140628905698, 5837.6497410155525, 5883.558733095035, 5972.641641501524, 6038.396160384014, 6112.663803490851, 5538.556915446755, 5554.50009499147, 5581.888362232733, 5589.664620122724, 5612.859678507988, 4931.778069986787, 5101.311322971425, 5109.846704598868, 5113.054084994288, 5154.484551544815, 6094.0, 6099.542534309944, 6115.149072927094, 6174.38256174388, 6200.0, 5969.671668058299, 5978.521718262616, 5985.461308482258, 6049.66726830011, 6054.90917636227, 6192.628442293477, 6193.38066193377, 6218.5647004709235, 6226.62640241587, 6251.0623406487575, 5831.7375718091935, 5867.765289388377, 5924.585279030426, 5943.0, 6037.426444487766, 5943.227380440515, 5973.104034394702, 5975.551833612583, 6020.729067192075, 6068.726907289094, 5716.9428305718075, 5804.854878628068, 5863.530917526502, 5871.442212989759, 5882.970585147047, 5816.0, 5828.795992140254, 5846.766129354778, 5848.035074212878, 5925.348211696623, 5758.654480731169, 5772.682502462405, 5776.162456443876, 5807.274090738658, 5813.3895940925595, 5626.521745651666, 5717.914231286451, 5918.2898052234, 5937.762489500372, 5957.523398128226, 5687.431256874445, 5799.130130480462, 5810.854728631818, 5814.505767009851, 5864.706764661664], "unit": "score", "name": "dojo.html", "value": 5502.165188028507}, {"lowerIsBetter": false, "replicates": [592.5999950033727, 596.049301364324, 601.8044135655912, 602.4427404650697, 612.249993757647, 39662.801685991566, 40427.978601069975, 40591.99999999996, 40632.796836015776, 40682.796586017066, 44379.0, 45022.32466513005, 45036.3244551332, 45099.54900450994, 45102.77448612761, 8729.432586881863, 8825.205731484166, 8894.555272236395, 8894.777630559223, 8909.554522273893, 8584.442011269279, 8612.18184272493, 8648.913510864904, 8669.609867555944, 8676.956615216915, 8689.348298877609, 8750.124987501262, 8753.212210901018, 8762.561871906411, 8790.384673072887, 8669.826603467927, 8670.826583468326, 8719.782005449852, 8735.694250701226, 8772.649094036231, 8573.314134869195, 8654.177853103945, 8682.26200772935, 8718.302535797184, 8726.04013558508, 39961.20077598461, 40563.0, 40693.0, 40706.38940415896, 40710.59289407098, 3379.374815659111, 3412.522246885438, 3432.502287168347, 3466.584009918801, 3961.0, 28828.711712882814, 29008.41983160346, 29049.273768155756, 29757.702422975708, 30320.696793032006, 3928.116173860887, 3933.7836418996944, 3956.36698128301, 3971.126352202511, 4055.3916912463364, 269473.0, 270366.0, 270427.0, 271047.0, 272477.0, 43860.78069609631, 44259.33610995838, 44517.332240016425, 44681.329780053326, 62057.68971155115, 43026.569734302255, 43101.56898431038, 43120.0, 43287.0, 43294.35058474125, 14505.637359065897, 14747.0, 14870.628234294229, 14905.850941490446, 15093.47172848945, 11526.88473115275, 11699.649010529698, 11739.941300293443, 11753.588624398106, 11768.646940591796, 14409.351579178961, 14421.278936053155, 14446.85553144476, 14485.0, 14556.636084097981, 5745.770169193269, 5756.884862302814, 5786.768529258867, 5809.738561764731, 5857.088635410257, 960.3373672166183, 972.6158167523788, 991.4546999150439, 1049.8635177426886, 1119.4011204005817, 28061.298467538476, 28327.71672283292, 28474.145775626763, 28740.0, 28907.277318066797, 1017.4607458047246, 1043.2436483549518, 1059.8039362717768, 1079.8056349857102, 1128.1426116151783, 13985.3706583204, 14064.578062658136, 14129.222892740998, 16210.513684589481, 16736.665266694843, 387962.0, 389381.0, 391918.0, 392359.0, 393909.0, 53146.202806957925, 53215.733921330146, 53382.19926701103, 53601.731991339795, 53771.0, 1309.7773378525674, 1317.8155058291848, 1317.9341032948314, 1323.5367621332648, 1337.1843175662839, 28979.710202897702, 29477.0, 29700.405991880474, 29736.702632973393, 30160.84919575388, 44799.328010079225, 45379.54620453753, 45425.318620221384, 45523.544764553255, 45527.54472455233, 308227.0, 311504.0, 312717.0, 313020.0, 313962.0, 31687.683123168474, 44961.32558011567, 46168.30747538722, 46431.76784116058, 46687.29969050399, 42615.74637958529, 43335.13329733325, 43354.56645433505, 43552.34671479867, 43977.34033989429, 36286.0, 36320.0, 36420.27159456849, 37026.44460333151, 37154.25691486209, 35700.285994280486, 36539.817300913324, 36568.26863462663, 36602.45096323611, 39511.0, 35144.64855351516, 35581.0, 35702.46446303256, 35740.82129589335, 36174.09564760902, 31557.842210789717, 32764.180895477803, 33065.0, 33077.17307067342, 33581.66418335883, 27216.863915680296, 27733.117363568712, 27777.166684999484, 27812.44375112527, 27914.0], "unit": "score", "name": "ext.html", "value": 18385.568445527148}, {"lowerIsBetter": false, "replicates": [339.43484098975205, 343.1626830533497, 344.6777263258853, 344.71560962206183, 348.2651605113211, 17468.301267949297, 17524.73712894306, 17890.73163902541, 18259.452216433496, 18431.262749490023, 16237.0, 16565.25456354464, 16873.578160545963, 17252.30990760368, 17292.30830766771, 4836.202026665596, 4921.532454416824, 4952.306677065214, 4963.751812409383, 4965.932324550221, 4906.852794416173, 4944.604431645478, 4989.57588604969, 4998.200287953928, 5025.422076461199, 4962.900741985158, 5025.899482010358, 5031.421386540558, 5096.566791822681, 5277.525022747952, 5236.0, 5236.109861323546, 5242.370915490127, 5264.236685680574, 5271.103912334912, 5129.7435128243815, 5314.256004159421, 5327.200919862013, 5338.813141540067, 5341.03861304965, 19792.109355079057, 19805.306814261432, 19915.50211244716, 20324.085416156307, 20440.0, 1993.571382152844, 2162.308061420346, 2180.5529866377515, 2200.6368949123375, 2209.281983355416, 9718.222542196678, 9787.217022638171, 9794.804103917953, 9886.258530610234, 9909.20726341898, 1792.2562136713248, 1825.2151574822822, 1832.4044685477272, 1835.7613510243582, 1852.703567429205, 58033.0, 59376.40623593795, 60869.08696369558, 64937.675311623614, 65053.67473162651, 9647.1317581418, 9806.509674516246, 10011.649592264235, 10299.485025748683, 10353.0, 13547.187168769906, 13550.119242249419, 13584.184948903097, 13585.59243222705, 13598.796018059737, 7773.689052437952, 7777.261160189773, 7806.1413244543055, 7827.6477558510005, 7849.686012559548, 7696.576688282198, 7712.267334603203, 7735.762278035488, 7764.495307804975, 7773.261540153676, 4516.932246016312, 4576.222042252825, 4578.587927086578, 4582.243929751554, 4587.8623641290815, 1836.0544319675378, 1859.191251805469, 1871.4105056907304, 1876.211990963771, 1880.539267879351, 418.8094417040239, 420.2624394188241, 439.86364227089064, 445.8127586413714, 447.6280201183363, 10852.837207441895, 11091.72270693239, 11110.444477776078, 11119.0, 11277.154213434025, 445.24975416422785, 450.6394884092713, 451.37935338909, 460.1326499548375, 888.0897080492417, 8813.383063185644, 9074.364794464323, 9594.568244429018, 10230.744231394126, 10238.744031399274, 509053.0, 561942.0, 562999.0, 573524.0, 577669.0, 82927.0, 85118.5744071288, 86107.0, 87510.0, 88153.0, 1141.594733869481, 1156.8958793708607, 1168.1063986050508, 1171.2679575265458, 1174.4949671641104, 16015.599610009844, 16074.196290185679, 16134.435294764628, 16185.190740463166, 16516.42192523256, 36305.27389452144, 36317.45523817198, 36598.26803463969, 36668.81665591762, 37402.0, 47252.29121563111, 49880.501194987584, 50443.49556504535, 52527.737361312946, 53215.20177197268, 9493.620255189991, 9600.423974561549, 9665.275104367342, 9671.129598336183, 9703.466309353053, 14124.364403601658, 17273.91363043177, 17850.821491784915, 17973.0, 18083.54791130232, 13871.306434678025, 14283.214423206824, 14634.707305854035, 14679.119252844863, 14740.189289589176, 11743.706407339885, 13931.58205253844, 14329.283535822959, 14408.42366305378, 14445.85554144445, 14962.700745985238, 15017.77473337879, 15035.924820375829, 15169.696606067597, 15174.924125379302, 9649.179819715122, 9812.411255324418, 9865.901340986498, 9904.207663387057, 9968.950155249468, 14280.35738391754, 14334.354954026885, 14380.712385752435, 14414.630610092025, 14574.34415451286], "unit": "score", "name": "jquery.html", "value": 8547.11657138514}, {"lowerIsBetter": false, "replicates": [1401.866822651848, 1452.7385070687276, 1575.2202659683458, 1741.5559032446731, 1755.89464632122, 6752.966235168823, 7200.783976480701, 7233.4574906881935, 7493.587852668101, 7672.539647621146, 7454.180040195574, 7561.168271490132, 7562.584057876815, 7563.584002879839, 7582.128055273645, 2188.890555472228, 2239.7200349956256, 2240.6078936186104, 2242.8990695418747, 2246.2587346175806, 2220.855644383118, 2239.428945618865, 2245.5059886824874, 2261.694671219389, 2267.2631394796676, 2190.8356873234493, 2223.43302457873, 2231.542533780571, 2244.2033078257227, 2254.9436264093365, 2184.7159869217057, 2202.9889850550726, 2220.433789383713, 2228.6322756745117, 2235.1729859951843, 2218.556288742242, 2236.6197746383154, 2241.8766967816764, 2251.0, 2258.8757618330983, 7285.708571657127, 7326.120865496121, 7355.227701091415, 7355.2644735526555, 7388.9261107388775, 4512.751798651106, 4604.079184163181, 4604.884877878047, 4605.332226827125, 4608.147492713859, 3088.366884788613, 3099.2871639523037, 3216.5979252593424, 3219.710226079664, 3233.143217047484, 1109.4563663804677, 1129.24904938216, 1133.0425790207262, 1134.2457265918154, 1141.452102990561, 9653.469059201741, 9735.951320243354, 9786.951065244699, 9816.165625921805, 9819.509024548744, 3878.5539662939123, 3914.5106861642294, 3926.8821935341984, 3986.382110772835, 4001.4998125234347, 8098.51408915467, 8122.268995790289, 8129.0, 8157.714479993172, 8159.632816523271, 4423.690341676116, 4423.690341676116, 4440.067585806952, 4440.622547083534, 4443.6889417741095, 4098.549159592442, 4129.29801933672, 4145.0, 4161.063760653889, 4203.936940945889, 3402.9110684580696, 3415.231572896128, 3426.0749597608506, 3435.9828200858838, 3450.551428314303, 1049.0610903241557, 1058.4866339825178, 1059.6873922192972, 1060.390275591538, 1063.4788953412926, 933.2673851026912, 936.0826390137703, 941.9293552983554, 1005.5324274212526, 1332.0742084251547, 7070.92929070713, 7095.751648692271, 7112.679929403189, 7116.252793456612, 7122.679479423438, 494.3795536601614, 1181.8463599731979, 1195.0678470792795, 1208.7401208739986, 1214.4838443661408, 5697.373288938214, 5717.2281741965135, 5745.885082298414, 5763.510101641324, 5766.106253530709, 8526.701565445179, 8548.273396761346, 8639.222469977733, 8807.91192088071, 8810.20708136258, 8500.14998500145, 8610.354223433142, 8627.827443451222, 8630.741077767552, 8727.0, 6957.443404527626, 7025.0, 7050.541714788523, 7068.752593659197, 7147.106611673541, 7143.214246432992, 7217.927820721936, 7227.7831665050135, 7231.059962204879, 7260.564366137837, 8007.479513831582, 8050.919490805251, 8230.670773169006, 8266.504009759434, 8357.540335281617, 8166.591670416574, 8307.460015098999, 8370.874436883574, 8395.24442800151, 8411.200935911078, 5914.112883067574, 6341.619502829845, 6507.12153859223, 6563.868722625425, 6648.767293144717, 7181.856362872609, 7207.819804504929, 7261.6006119663925, 7273.9636301818155, 7291.744788932362, 6663.633500157538, 6894.482913781587, 6906.274841141608, 6915.377616014382, 6964.0598519201285, 6667.399934005769, 6671.566348187353, 6675.632840193836, 6795.966020169867, 6800.489963252875, 6804.727810887509, 6867.896981545381, 6869.725210991504, 6897.793066208022, 6905.205901321412, 6114.38856114385, 6163.506919446344, 6185.072239164161, 6191.473724733448, 6201.875962480635, 6084.847878803065, 6086.756529738938, 6106.389361063858, 6113.633182009094, 6134.35589263121], "unit": "score", "name": "mootools.html", "value": 4323.462331959773}, {"lowerIsBetter": false, "replicates": [319.60528746997454, 321.4775989017846, 324.6072252574385, 329.2312450428251, 329.93401319736046, 6381.904271435932, 6391.488680905528, 6400.9039864402075, 6461.289258181602, 6519.543631945766, 6289.842753931154, 6346.460550853183, 6357.904631430532, 6359.364063593638, 6383.904241436382, 4758.643101767364, 4799.856004319859, 4805.0389922015565, 4806.3030860525205, 4814.229723244282, 4799.112164249625, 4799.712017278957, 4803.63972702047, 4805.495422980589, 4819.951800481986, 4683.437987441494, 4755.167845627001, 4772.90454190916, 4775.594074503671, 4780.282957556377, 4766.2374020156785, 4766.642501812361, 4771.570558649738, 4779.020300838337, 4779.569838714532, 4119.340905455113, 4124.092699606082, 4131.111810960628, 4138.979305103455, 4143.08852052548, 6048.425399587032, 6065.150878876917, 6068.726907289182, 6073.028315469548, 6074.878502429927, 5453.0, 5571.1086226203615, 5577.776888924438, 5580.302462192226, 5581.0, 6715.3620406061345, 6727.865442691168, 6748.527603067787, 6751.594904305757, 6756.189257289157, 4573.634109271284, 4589.79345929434, 4591.977040114778, 4592.517785632527, 4602.079584083197, 6844.691988860513, 6964.233934267227, 7015.754448594325, 7038.296170382972, 7083.0, 4566.520515345907, 4605.424321959755, 4606.401167848158, 4611.584957353854, 4611.76941152941, 4663.020765639254, 4666.253399456071, 4666.416697912761, 4668.743219122913, 4673.345731597579, 5482.835514934558, 5483.643563168382, 5486.341639003345, 5490.752916118784, 5490.917636235459, 6629.303923088103, 6787.457003439713, 6792.0830687856505, 6794.796156115324, 6798.76204332846, 1587.1429428108922, 1623.7320842060928, 1640.753886916972, 1640.9425670101489, 1642.3348543839763, 1060.8037513059953, 1066.6106870992032, 1069.4118234970736, 1077.28898926708, 1077.5851297250615, 6331.746730130743, 6344.302126766052, 6346.079818426395, 6350.809475715643, 6357.777477788255, 6833.077534532874, 6854.2117656470145, 6874.725010999504, 6886.001529778154, 6903.0, 6204.0, 6342.080398342215, 6344.619322840552, 6350.206224221973, 6355.205599300088, 3740.831662575191, 3756.6243375662216, 3759.6052414496085, 3767.566729826105, 3767.660910518012, 7122.2521635228595, 7128.358447739728, 7129.0, 7132.215456299803, 7134.500584959003, 7011.92988070123, 7039.894401583981, 7044.718211271595, 7057.294270572902, 7064.752733654297, 7370.484066115428, 7385.66764495599, 7403.8149046274275, 7404.666789994463, 7408.888866667005, 7042.119735033121, 7061.576305421691, 7078.398336141486, 7082.3979961703835, 7092.858142837011, 6894.0, 6977.302269773185, 6985.196702379291, 6985.825354366181, 7032.578045317297, 7311.4516411268305, 7340.412766978736, 7369.926300736924, 7380.5940673263485, 7383.593902335423, 4699.459562150397, 4724.834630788044, 4725.125851717443, 4729.030548737569, 4743.976280118577, 6870.587764734132, 6904.93095069063, 7012.2286548478605, 7056.823579410556, 7102.644867756695, 6795.966020169867, 6825.215100263533, 6850.862982740217, 6857.657117144223, 6891.655417229219, 6803.795886123424, 6831.9316806833285, 6832.863342733217, 6845.965770171118, 6878.759243426456, 6540.705668244846, 6726.562773419712, 6728.596284222962, 6730.966345168439, 6739.764108256188, 6886.965565172142, 6903.1716194057035, 6911.75808846688, 6911.75808846688, 6935.653217339012, 6669.599824010575, 6678.298778628368, 6711.530192886451, 6741.797746067626, 6743.561668491532], "unit": "score", "name": "prototype.html", "value": 5040.34864464289}, {"lowerIsBetter": false, "replicates": [757.9848403031936, 761.649641165064, 813.9715109971148, 842.7162389923308, 882.7837179890926, 13529.864701352995, 13608.455661773518, 13662.931685341584, 13668.316584170776, 13768.38042288097, 12559.120861539695, 12750.68123296918, 14621.92689036556, 14737.115773053625, 14760.926195369007, 821.6384790692106, 824.3240542754943, 824.8020475085996, 825.7275099217273, 826.1903334731982, 828.2628460670009, 844.0040751912741, 844.4426678392263, 844.5144042175742, 846.9110743371949, 859.4800145911727, 869.1091631078132, 870.7431307764193, 873.4846440600045, 875.5097145598453, 865.9610317535695, 868.5266529741306, 869.3219288954593, 871.4422769427572, 875.0767939823547, 636.1697984130708, 637.6970938804031, 638.3201889987196, 638.3297537585563, 639.2041907824741, 13508.729825403438, 13634.454621815115, 13646.86353136466, 13730.176189428666, 13737.313134343243, 11377.089832813355, 11472.942635286854, 11711.180217384786, 11937.880621193764, 12345.938270308681, 9050.597157440607, 9236.353455258135, 9791.755206119833, 10380.11768999636, 10450.84323735137, 3623.076115590534, 3658.902329301199, 3673.412254039368, 3720.776753394778, 3800.448934904451, 44093.77953110214, 44482.55517444816, 45042.54957450416, 45127.54872451299, 45135.54864451346, 9355.158035776813, 9914.157296629723, 9933.701988940198, 9956.601735930626, 10329.586816527404, 17389.217485213198, 17405.912970435067, 17461.563460913323, 17487.912560437115, 17599.384021559184, 7511.474196806281, 7670.117936437381, 7791.961040194763, 7792.493487923267, 7793.532388056735, 4393.560643935581, 4472.508024117345, 4537.342085397599, 4580.083983203306, 4595.126925884071, 3070.1557071805432, 3098.1170366445454, 3102.488089465213, 3103.472409690358, 3111.9377612447624, 558.1460365640577, 570.0565563991518, 574.5949105880344, 577.1170109732117, 580.5964854426218, 656.6486929492698, 676.4723515657795, 692.2489099327287, 702.8840241360118, 704.6969802984663, 8283.0, 9050.728478145666, 9058.682946096855, 9268.582913768896, 9477.194438472668, 695.2664938489942, 709.1667290933133, 713.3187805645596, 722.9024081749002, 725.4341613541446, 3987.6211759882763, 4225.619694227473, 4235.745855248695, 4338.717983331074, 4382.6055654991205, 63242.0, 64764.0, 64958.72644457421, 65094.0, 65141.348586514476, 51497.0, 51582.48417515852, 51834.74082629563, 51844.740776295876, 52475.0, 47013.0, 47130.76434617874, 47605.0, 49049.0, 49575.0, 8409.53747543891, 8534.74395768128, 8608.48349099056, 8914.108589141035, 8982.86525702128, 36606.0, 37156.62843371532, 37473.81263093667, 38215.61784382232, 38417.61582384141, 45956.77021615004, 46221.53778462172, 46232.0, 46419.53580464152, 46762.532374677176, 10705.732356691145, 10767.784644307227, 11056.0, 11061.944690276498, 11264.549418023187, 12518.186317889673, 12557.87442125567, 12561.560345387868, 12703.36483175856, 13073.869261307265, 11311.604093857004, 11794.52821887115, 11825.172237943261, 11942.223755455867, 12207.0, 11812.70468238301, 11968.222065565711, 12039.578614748441, 12068.939655301667, 12487.812682809583, 11185.217034807485, 11260.662180134608, 11543.191976561897, 11918.582849600223, 12050.337231452355, 9705.417674939526, 9739.366941148803, 9747.999107961557, 9755.268354873555, 9789.265805064506, 8356.247937685637, 9191.724248272563, 9987.650432234837, 10005.399676019462, 10033.799324013333], "unit": "score", "name": "yui.html", "value": 6451.445991818303}], "name": "dromaeo_css", "value": 7038.327154395734}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 112.0, 110.0, 111.0, 122.0, 109.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [152.0, 123.0, 153.0, 167.0, 127.0, 153.0, 161.0, 131.0, 161.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 163.0, 162.0, 162.0, 162.0, 162.0, 164.0, 175.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 73.0, 75.0, 72.0, 147.0, 74.0, 72.0, 71.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 135.0, 93.0, 93.0, 93.0, 140.0, 94.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 112.0, 110.0, 112.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 59.0, 60.0, 62.0, 60.0, 58.0, 59.0, 58.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 70.0, 70.0, 69.0, 70.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [84.0, 92.0, 86.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [121.0, 116.0, 130.0, 116.0, 125.0, 131.0, 121.0, 119.0, 132.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.1}, {"lowerIsBetter": true, "replicates": [144.0, 150.0, 151.0, 149.0, 154.0, 150.0, 151.0, 148.0, 162.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1513.3999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [194.51468585878234], "unit": "score", "name": "DeltaBlue", "value": 339.9126379999999}, {"lowerIsBetter": false, "replicates": [284.1716396703609], "unit": "score", "name": "Encrypt", "value": 936.6909390000004}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1086.9565217391305], "unit": "score", "name": "RayTrace", "value": 680.7898799999998}, {"lowerIsBetter": false, "replicates": [756.4296520423601], "unit": "score", "name": "Earley", "value": 881.0640860000002}, {"lowerIsBetter": false, "replicates": [11976.190476190477], "unit": "score", "name": "Boyer", "value": 55.648998011928406}, {"lowerIsBetter": false, "replicates": [24829.268292682926], "unit": "score", "name": "RegExp", "value": 36.68996561886052}, {"lowerIsBetter": false, "replicates": [639.7952655150352], "unit": "score", "name": "Splay", "value": 127.37043299999999}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21072.5736247489}]} 17:24:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21072.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1513.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7038.33"}}} 17:24:54 INFO - Return code: 0 17:24:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:24:54 INFO - # TBPL SUCCESS # 17:24:54 INFO - Running post-action listener: _resource_record_post_action 17:24:54 INFO - Running post-run listener: _resource_record_post_run 17:24:55 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 176128; Write bytes: 556642304; Read time: 328; Write time: 573016 17:24:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 8192; Write bytes: 234786816; Read time: 260; Write time: 344144 17:24:55 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 167936; Write bytes: 321515520; Read time: 68; Write time: 228848 17:24:55 INFO - Running post-run listener: _upload_blobber_files 17:24:55 INFO - Blob upload gear active. 17:24:55 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:24:55 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 17:24:55 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:24:55 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:24:55 INFO - (blobuploader) - INFO - Open directory for files ... 17:24:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:24:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:24:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:56 INFO - (blobuploader) - INFO - Done attempting. 17:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:24:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:24:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:57 INFO - (blobuploader) - INFO - Done attempting. 17:24:57 INFO - (blobuploader) - INFO - Iteration through files over. 17:24:57 INFO - Return code: 0 17:24:57 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:24:57 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:24:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54743531ab403a756bb3c1d24250440c21973fa702972a98dea3f24a9e602903d35095b8f8c955c8fb754792ea6f5f15f3df05ba3d53508e735bd495e8a429ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08298e1dccab591b361233df3e16bdf7e45ee4c362c5a8850fc762c63d68cdc7ef83d52a5f8b5f62bb43edd39c1e03a732fef30ac1887c037dfbf49f92c0b47c"} 17:24:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:24:57 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:24:57 INFO - Contents: 17:24:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54743531ab403a756bb3c1d24250440c21973fa702972a98dea3f24a9e602903d35095b8f8c955c8fb754792ea6f5f15f3df05ba3d53508e735bd495e8a429ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08298e1dccab591b361233df3e16bdf7e45ee4c362c5a8850fc762c63d68cdc7ef83d52a5f8b5f62bb43edd39c1e03a732fef30ac1887c037dfbf49f92c0b47c"} 17:24:57 INFO - Copying logs to upload dir... 17:24:57 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.336857 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-23 17:24:57.593609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 17:24:57.596889) ========= 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=d333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608 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/Fx-Team/sha512/54743531ab403a756bb3c1d24250440c21973fa702972a98dea3f24a9e602903d35095b8f8c955c8fb754792ea6f5f15f3df05ba3d53508e735bd495e8a429ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08298e1dccab591b361233df3e16bdf7e45ee4c362c5a8850fc762c63d68cdc7ef83d52a5f8b5f62bb43edd39c1e03a732fef30ac1887c037dfbf49f92c0b47c"} build_url:https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/RQ-LbU4pTJCwkBkBXGDkzg/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/Fx-Team/sha512/54743531ab403a756bb3c1d24250440c21973fa702972a98dea3f24a9e602903d35095b8f8c955c8fb754792ea6f5f15f3df05ba3d53508e735bd495e8a429ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08298e1dccab591b361233df3e16bdf7e45ee4c362c5a8850fc762c63d68cdc7ef83d52a5f8b5f62bb43edd39c1e03a732fef30ac1887c037dfbf49f92c0b47c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 17:24:57.624049) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 17:24:57.624716) ========= 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=d333f129428bd91e5d9d687c000001bd-1450916865.24707-1284515608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 17:24:57.705703) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 17:24:57.706058) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 17:24:57.706384) ========= ========= Total master_lag: 0.21 =========