builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1453261632.58 results: success (0) buildid: 20160119173009 builduid: 8e71d5e027604680aece434ea6f80d7a revision: 266fae559621e55d614f52c66e95c08228aef8ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.576828) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.577332) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.577624) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006426 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.630165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.630484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.734335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.734627) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.804613) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.804919) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.805291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:12.805578) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 19:47:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-01-19 19:47:13 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.213837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.033580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.033977) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016325 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.084710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.085036) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 266fae559621e55d614f52c66e95c08228aef8ca --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 266fae559621e55d614f52c66e95c08228aef8ca --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=3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 19:47:13,887 truncating revision to first 12 chars 2016-01-19 19:47:13,888 Setting DEBUG logging. 2016-01-19 19:47:13,888 attempt 1/10 2016-01-19 19:47:13,888 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/266fae559621?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 19:47:14,129 unpacking tar archive at: fx-team-266fae559621/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.644224) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.644556) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004908 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.696285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.696563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.708205) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.708475) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 19:47:13.709137) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-19 19:47:13.709448) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --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', '--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=3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:47:14 INFO - MultiFileLogger online at 20160119 19:47:14 in /builds/slave/test-pgo 19:47:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:47:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:47:14 INFO - {'append_to_log': False, 19:47:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:47:14 INFO - 'blob_upload_branch': 'Fx-Team', 19:47:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:47:14 INFO - 'branch': 'Fx-Team', 19:47:14 INFO - 'buildbot_json_path': 'buildprops.json', 19:47:14 INFO - 'config_files': ('talos/linux_config.py',), 19:47:14 INFO - 'default_actions': ('clobber', 19:47:14 INFO - 'read-buildbot-config', 19:47:14 INFO - 'download-and-extract', 19:47:14 INFO - 'populate-webroot', 19:47:14 INFO - 'create-virtualenv', 19:47:14 INFO - 'install', 19:47:14 INFO - 'run-tests'), 19:47:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:47:14 INFO - 'download_minidump_stackwalk': True, 19:47:14 INFO - 'download_symbols': 'ondemand', 19:47:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:47:14 INFO - 'tooltool.py': '/tools/tooltool.py', 19:47:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:47:14 INFO - '/tools/misc-python/virtualenv.py')}, 19:47:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:47:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:47:14 INFO - 'installer_path': 'installer.exe', 19:47:14 INFO - 'log_level': 'info', 19:47:14 INFO - 'log_name': 'talos', 19:47:14 INFO - 'log_to_console': True, 19:47:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:47:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:47:14 INFO - 'opt_config_files': (), 19:47:14 INFO - 'pip_index': False, 19:47:14 INFO - 'sps_profile': False, 19:47:14 INFO - 'sps_profile_interval': 0, 19:47:14 INFO - 'suite': 'dromaeojs-e10s', 19:47:14 INFO - 'system_bits': '32', 19:47:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:47:14 INFO - 'title': 'talos-linux64-ix-059', 19:47:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:47:14 INFO - 'use_talos_json': True, 19:47:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:47:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:47:14 INFO - 'work_dir': 'build'} 19:47:14 INFO - ##### 19:47:14 INFO - ##### Running clobber step. 19:47:14 INFO - ##### 19:47:14 INFO - Running pre-action listener: _resource_record_pre_action 19:47:14 INFO - Running main action method: clobber 19:47:14 INFO - rmtree: /builds/slave/test-pgo/build 19:47:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:47:15 INFO - Running post-action listener: _resource_record_post_action 19:47:15 INFO - ##### 19:47:15 INFO - ##### Running read-buildbot-config step. 19:47:15 INFO - ##### 19:47:15 INFO - Running pre-action listener: _resource_record_pre_action 19:47:15 INFO - Running main action method: read_buildbot_config 19:47:15 INFO - Using buildbot properties: 19:47:15 INFO - { 19:47:15 INFO - "project": "", 19:47:15 INFO - "product": "firefox", 19:47:15 INFO - "script_repo_revision": "production", 19:47:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:47:15 INFO - "repository": "", 19:47:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:47:15 INFO - "buildid": "20160119173009", 19:47:15 INFO - "pgo_build": "True", 19:47:15 INFO - "basedir": "/builds/slave/test-pgo", 19:47:15 INFO - "buildnumber": 223, 19:47:15 INFO - "slavename": "talos-linux64-ix-059", 19:47:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:47:15 INFO - "platform": "ubuntu64_hw", 19:47:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:47:15 INFO - "branch": "fx-team", 19:47:15 INFO - "repo_path": "integration/fx-team", 19:47:15 INFO - "revision": "266fae559621e55d614f52c66e95c08228aef8ca", 19:47:15 INFO - "stage_platform": "linux64-pgo", 19:47:15 INFO - "builduid": "8e71d5e027604680aece434ea6f80d7a", 19:47:15 INFO - "slavebuilddir": "test" 19:47:15 INFO - } 19:47:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:47:15 INFO - Running post-action listener: _resource_record_post_action 19:47:15 INFO - ##### 19:47:15 INFO - ##### Running download-and-extract step. 19:47:15 INFO - ##### 19:47:15 INFO - Running pre-action listener: _resource_record_pre_action 19:47:15 INFO - Running main action method: download_and_extract 19:47:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:15 INFO - https://queue.taskcluster.net/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:47:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/test_packages.json 19:47:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/test_packages.json 19:47:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:47:18 INFO - Downloaded 1448 bytes. 19:47:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:47:18 INFO - Using the following test package requirements: 19:47:18 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:47:18 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:47:18 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:47:18 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:18 INFO - u'jsshell-linux-x86_64.zip'], 19:47:18 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:47:18 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:47:18 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:47:18 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:47:18 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:47:18 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:47:18 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:47:18 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:18 INFO - https://queue.taskcluster.net/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:47:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:47:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:47:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/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 19:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/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 19:47:19 INFO - Downloaded 22485690 bytes. 19:47:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:47:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:47:20 INFO - Return code: 0 19:47:20 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 19:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:20 INFO - https://queue.taskcluster.net/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/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 19:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/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 19:47:23 INFO - Downloaded 22485690 bytes. 19:47:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:47:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:47:24 INFO - Return code: 0 19:47:24 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')]} 19:47:24 INFO - https://queue.taskcluster.net/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:47:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:47:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:47:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/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 19:47:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/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 19:47:25 INFO - Downloaded 11132144 bytes. 19:47:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:47:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:47:25 INFO - Return code: 0 19:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:25 INFO - https://queue.taskcluster.net/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:47:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:47:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:47:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/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 19:47:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cv2D7QpQTKONj-TTyAr-1g/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 19:47:27 INFO - Downloaded 55907944 bytes. 19:47:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:47:27 INFO - mkdir: /builds/slave/test-pgo/properties 19:47:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:47:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:47:27 INFO - Contents: 19:47:27 INFO - build_url:https://queue.taskcluster.net/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:47:27 INFO - Running post-action listener: _resource_record_post_action 19:47:27 INFO - Running post-action listener: set_extra_try_arguments 19:47:27 INFO - ##### 19:47:27 INFO - ##### Running populate-webroot step. 19:47:27 INFO - ##### 19:47:27 INFO - Running pre-action listener: _resource_record_pre_action 19:47:27 INFO - Running main action method: populate_webroot 19:47:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:47:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:47:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:47:27 INFO - '--tppagecycles', 19:47:27 INFO - '7'], 19:47:27 INFO - 'tests': ['tsvgm']}}, 19:47:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:47:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:47:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:47:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:47:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:47:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:47:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:47:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:27 INFO - 'talos_options': ['--e10s'], 19:47:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:47:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:27 INFO - 'tests': ['damp', 'tps']}, 19:47:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:27 INFO - 'talos_options': ['--e10s'], 19:47:27 INFO - 'tests': ['damp', 'tps']}, 19:47:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:47:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:47:27 INFO - 'other': {'tests': ['a11yr', 19:47:27 INFO - 'ts_paint', 19:47:27 INFO - 'tpaint', 19:47:27 INFO - 'sessionrestore', 19:47:27 INFO - 'sessionrestore_no_auto_restore']}, 19:47:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:47:27 INFO - 'tests': ['a11yr', 19:47:27 INFO - 'ts_paint', 19:47:27 INFO - 'tpaint', 19:47:27 INFO - 'sessionrestore', 19:47:27 INFO - 'sessionrestore_no_auto_restore']}, 19:47:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:47:27 INFO - 'tests': ['a11yr', 19:47:27 INFO - 'ts_paint', 19:47:27 INFO - 'tpaint', 19:47:27 INFO - 'sessionrestore', 19:47:27 INFO - 'sessionrestore_no_auto_restore']}, 19:47:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:47:27 INFO - 'tests': ['a11yr', 19:47:27 INFO - 'ts_paint', 19:47:27 INFO - 'tpaint', 19:47:27 INFO - 'sessionrestore', 19:47:27 INFO - 'sessionrestore_no_auto_restore']}, 19:47:27 INFO - 'other_l64': {'tests': ['a11yr', 19:47:27 INFO - 'ts_paint', 19:47:27 INFO - 'tpaint', 19:47:27 INFO - 'sessionrestore', 19:47:27 INFO - 'sessionrestore_no_auto_restore']}, 19:47:27 INFO - 'other_nol64': {'tests': ['a11yr', 19:47:27 INFO - 'ts_paint', 19:47:27 INFO - 'tpaint', 19:47:27 INFO - 'sessionrestore', 19:47:27 INFO - 'sessionrestore_no_auto_restore']}, 19:47:27 INFO - 'svgr': {'tests': ['tsvgx', 19:47:27 INFO - 'tsvgr_opacity', 19:47:27 INFO - 'tart', 19:47:27 INFO - 'tscrollx', 19:47:27 INFO - 'cart']}, 19:47:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:47:27 INFO - 'tests': ['tsvgx', 19:47:27 INFO - 'tsvgr_opacity', 19:47:27 INFO - 'tart', 19:47:27 INFO - 'tscrollx', 19:47:27 INFO - 'cart']}, 19:47:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:27 INFO - 'tests': ['tp5o']}, 19:47:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:27 INFO - 'talos_options': ['--e10s'], 19:47:27 INFO - 'tests': ['tp5o']}, 19:47:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:27 INFO - 'talos_options': ['--xperf_path', 19:47:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:47:27 INFO - 'tests': ['tp5n']}, 19:47:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:27 INFO - 'talos_options': ['--e10s', 19:47:27 INFO - '--xperf_path', 19:47:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:47:27 INFO - 'tests': ['tp5n']}}, 19:47:27 INFO - 'talos.zip': {'path': '', 19:47:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:47:27 INFO - Running post-action listener: _resource_record_post_action 19:47:27 INFO - ##### 19:47:27 INFO - ##### Running create-virtualenv step. 19:47:27 INFO - ##### 19:47:27 INFO - Running pre-action listener: _resource_record_pre_action 19:47:27 INFO - Running main action method: create_virtualenv 19:47:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:47:27 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 19:47:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:47:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:47:27 INFO - Using real prefix '/usr' 19:47:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:47:27 INFO - Installing distribute.............................................................................................................................................................................................done. 19:47:29 INFO - Installing pip.................done. 19:47:29 INFO - Return code: 0 19:47:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:29 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 0x7f57a7833f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf840>, '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 0x253c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253cb60>, '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': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', '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 19:47:29 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 19:47:29 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 19:47:29 INFO - Using env: {'DISPLAY': ':0', 19:47:29 INFO - 'HOME': '/home/cltbld', 19:47:29 INFO - 'LANG': 'en_US.UTF-8', 19:47:29 INFO - 'LANGUAGE': 'en_US:en', 19:47:29 INFO - 'LOGNAME': 'cltbld', 19:47:29 INFO - 'MAIL': '/var/mail/cltbld', 19:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:29 INFO - 'MOZ_NO_REMOTE': '1', 19:47:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:29 INFO - 'NO_EM_RESTART': '1', 19:47:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:29 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:29 INFO - 'SHELL': '/bin/bash', 19:47:29 INFO - 'SHLVL': '1', 19:47:29 INFO - 'TERM': 'linux', 19:47:29 INFO - 'TMOUT': '86400', 19:47:29 INFO - 'USER': 'cltbld', 19:47:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', 19:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:29 INFO - '_': '/tools/buildbot/bin/python'} 19:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:30 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 19:47:30 INFO - Cleaning up... 19:47:30 INFO - Return code: 0 19:47:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:47:30 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')]} 19:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:30 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')]} 19:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:30 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 0x7f57a7833f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf840>, '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 0x253c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253cb60>, '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': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', '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 19:47:30 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 19:47:30 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 19:47:30 INFO - Using env: {'DISPLAY': ':0', 19:47:30 INFO - 'HOME': '/home/cltbld', 19:47:30 INFO - 'LANG': 'en_US.UTF-8', 19:47:30 INFO - 'LANGUAGE': 'en_US:en', 19:47:30 INFO - 'LOGNAME': 'cltbld', 19:47:30 INFO - 'MAIL': '/var/mail/cltbld', 19:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:30 INFO - 'MOZ_NO_REMOTE': '1', 19:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:30 INFO - 'NO_EM_RESTART': '1', 19:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:30 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:30 INFO - 'SHELL': '/bin/bash', 19:47:30 INFO - 'SHLVL': '1', 19:47:30 INFO - 'TERM': 'linux', 19:47:30 INFO - 'TMOUT': '86400', 19:47:30 INFO - 'USER': 'cltbld', 19:47:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', 19:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:30 INFO - '_': '/tools/buildbot/bin/python'} 19:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:30 INFO - Downloading/unpacking psutil>=0.7.1 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 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 19:47:32 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:47:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:47:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:47:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:47:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:47:32 INFO - Installing collected packages: psutil 19:47:32 INFO - Running setup.py install for psutil 19:47:32 INFO - building 'psutil._psutil_linux' extension 19:47:32 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 19:47:32 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 19:47:32 INFO - building 'psutil._psutil_posix' extension 19:47:32 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 19:47:32 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 19:47:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:47:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:47:32 INFO - Successfully installed psutil 19:47:32 INFO - Cleaning up... 19:47:32 INFO - Return code: 0 19:47:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:32 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 0x7f57a7833f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf840>, '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 0x253c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253cb60>, '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': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', '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 19:47:32 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 19:47:32 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 19:47:32 INFO - Using env: {'DISPLAY': ':0', 19:47:32 INFO - 'HOME': '/home/cltbld', 19:47:32 INFO - 'LANG': 'en_US.UTF-8', 19:47:32 INFO - 'LANGUAGE': 'en_US:en', 19:47:32 INFO - 'LOGNAME': 'cltbld', 19:47:32 INFO - 'MAIL': '/var/mail/cltbld', 19:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:32 INFO - 'MOZ_NO_REMOTE': '1', 19:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:32 INFO - 'NO_EM_RESTART': '1', 19:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:32 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:32 INFO - 'SHELL': '/bin/bash', 19:47:32 INFO - 'SHLVL': '1', 19:47:32 INFO - 'TERM': 'linux', 19:47:32 INFO - 'TMOUT': '86400', 19:47:32 INFO - 'USER': 'cltbld', 19:47:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', 19:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:32 INFO - '_': '/tools/buildbot/bin/python'} 19:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:47:32 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 19:47:32 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 19:47:32 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 19:47:32 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 19:47:32 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 19:47:32 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 19:47:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:47:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:47:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:47:34 INFO - Installing collected packages: mozsystemmonitor 19:47:34 INFO - Running setup.py install for mozsystemmonitor 19:47:34 INFO - Successfully installed mozsystemmonitor 19:47:34 INFO - Cleaning up... 19:47:34 INFO - Return code: 0 19:47:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:34 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 0x7f57a7833f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf840>, '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 0x253c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253cb60>, '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': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', '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 19:47:34 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 19:47:34 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 19:47:34 INFO - Using env: {'DISPLAY': ':0', 19:47:34 INFO - 'HOME': '/home/cltbld', 19:47:34 INFO - 'LANG': 'en_US.UTF-8', 19:47:34 INFO - 'LANGUAGE': 'en_US:en', 19:47:34 INFO - 'LOGNAME': 'cltbld', 19:47:34 INFO - 'MAIL': '/var/mail/cltbld', 19:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:34 INFO - 'MOZ_NO_REMOTE': '1', 19:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:34 INFO - 'NO_EM_RESTART': '1', 19:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:34 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:34 INFO - 'SHELL': '/bin/bash', 19:47:34 INFO - 'SHLVL': '1', 19:47:34 INFO - 'TERM': 'linux', 19:47:34 INFO - 'TMOUT': '86400', 19:47:34 INFO - 'USER': 'cltbld', 19:47:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', 19:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:34 INFO - '_': '/tools/buildbot/bin/python'} 19:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:35 INFO - Downloading/unpacking blobuploader==1.2.4 19:47:35 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 19:47:35 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 19:47:35 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 19:47:35 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 19:47:35 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 19:47:35 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 19:47:36 INFO - Downloading blobuploader-1.2.4.tar.gz 19:47:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:47:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:47:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:47:36 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 19:47:36 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 19:47:36 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 19:47:36 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 19:47:36 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 19:47:36 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 19:47:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:47:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:47:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:47:37 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 19:47:37 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 19:47:37 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 19:47:37 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 19:47:37 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 19:47:37 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 19:47:37 INFO - Downloading docopt-0.6.1.tar.gz 19:47:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:47:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:47:37 INFO - Installing collected packages: blobuploader, requests, docopt 19:47:37 INFO - Running setup.py install for blobuploader 19:47:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:47:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:47:37 INFO - Running setup.py install for requests 19:47:37 INFO - Running setup.py install for docopt 19:47:38 INFO - Successfully installed blobuploader requests docopt 19:47:38 INFO - Cleaning up... 19:47:38 INFO - Return code: 0 19:47:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:47:38 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')]} 19:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:38 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')]} 19:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:38 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 0x7f57a7833f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf840>, '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 0x253c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253cb60>, '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': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', '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 19:47:38 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 19:47:38 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 19:47:38 INFO - Using env: {'DISPLAY': ':0', 19:47:38 INFO - 'HOME': '/home/cltbld', 19:47:38 INFO - 'LANG': 'en_US.UTF-8', 19:47:38 INFO - 'LANGUAGE': 'en_US:en', 19:47:38 INFO - 'LOGNAME': 'cltbld', 19:47:38 INFO - 'MAIL': '/var/mail/cltbld', 19:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:38 INFO - 'MOZ_NO_REMOTE': '1', 19:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:38 INFO - 'NO_EM_RESTART': '1', 19:47:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:38 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:38 INFO - 'SHELL': '/bin/bash', 19:47:38 INFO - 'SHLVL': '1', 19:47:38 INFO - 'TERM': 'linux', 19:47:38 INFO - 'TMOUT': '86400', 19:47:38 INFO - 'USER': 'cltbld', 19:47:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', 19:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:38 INFO - '_': '/tools/buildbot/bin/python'} 19:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:47:38 INFO - Running setup.py (path:/tmp/pip-RT4MTY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:47:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:47:38 INFO - Running setup.py (path:/tmp/pip-88Feuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:47:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:47:38 INFO - Running setup.py (path:/tmp/pip-Ev9xOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:47:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:47:38 INFO - Running setup.py (path:/tmp/pip-2bWnet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:47:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:47:38 INFO - Running setup.py (path:/tmp/pip-kicAXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:47:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:47:38 INFO - Running setup.py (path:/tmp/pip-hR5MnX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:47:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:47:38 INFO - Running setup.py (path:/tmp/pip-8Ui3BJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:47:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:47:38 INFO - Running setup.py (path:/tmp/pip-7tQfZR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:47:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:47:38 INFO - Running setup.py (path:/tmp/pip-0JBuO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:47:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:47:38 INFO - Running setup.py (path:/tmp/pip-nseHeG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:47:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:47:39 INFO - Running setup.py (path:/tmp/pip-ZsKfkK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:47:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:47:39 INFO - Running setup.py (path:/tmp/pip-ChFswC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:47:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:47:39 INFO - Running setup.py (path:/tmp/pip-NcCaRc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:47:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:47:39 INFO - Running setup.py (path:/tmp/pip-pnQ2qR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:47:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:47:39 INFO - Running setup.py (path:/tmp/pip-nDUe80-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:47:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:47:39 INFO - Running setup.py (path:/tmp/pip-hv5z9i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:47:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:47:39 INFO - Running setup.py (path:/tmp/pip-H8aTHA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:47:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:47:39 INFO - Running setup.py install for manifestparser 19:47:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:47:39 INFO - Running setup.py install for mozcrash 19:47:39 INFO - Running setup.py install for mozdebug 19:47:39 INFO - Running setup.py install for mozdevice 19:47:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:47:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:47:39 INFO - Running setup.py install for mozfile 19:47:40 INFO - Running setup.py install for mozhttpd 19:47:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Running setup.py install for mozinfo 19:47:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Running setup.py install for mozInstall 19:47:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Running setup.py install for mozleak 19:47:40 INFO - Running setup.py install for mozlog 19:47:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Running setup.py install for moznetwork 19:47:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Running setup.py install for mozprocess 19:47:40 INFO - Running setup.py install for mozprofile 19:47:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:47:40 INFO - Running setup.py install for mozrunner 19:47:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:47:41 INFO - Running setup.py install for mozscreenshot 19:47:41 INFO - Running setup.py install for moztest 19:47:41 INFO - Running setup.py install for mozversion 19:47:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:47:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:47:41 INFO - Cleaning up... 19:47:41 INFO - Return code: 0 19:47:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:41 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 0x7f57a7833f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf840>, '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 0x253c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253cb60>, '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': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', '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 19:47:41 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 19:47:41 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 19:47:41 INFO - Using env: {'DISPLAY': ':0', 19:47:41 INFO - 'HOME': '/home/cltbld', 19:47:41 INFO - 'LANG': 'en_US.UTF-8', 19:47:41 INFO - 'LANGUAGE': 'en_US:en', 19:47:41 INFO - 'LOGNAME': 'cltbld', 19:47:41 INFO - 'MAIL': '/var/mail/cltbld', 19:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:41 INFO - 'MOZ_NO_REMOTE': '1', 19:47:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:41 INFO - 'NO_EM_RESTART': '1', 19:47:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:41 INFO - 'SHELL': '/bin/bash', 19:47:41 INFO - 'SHLVL': '1', 19:47:41 INFO - 'TERM': 'linux', 19:47:41 INFO - 'TMOUT': '86400', 19:47:41 INFO - 'USER': 'cltbld', 19:47:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', 19:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:41 INFO - '_': '/tools/buildbot/bin/python'} 19:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:47:41 INFO - Running setup.py (path:/tmp/pip-ZhIoY9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:47:41 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)) 19:47:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:47:41 INFO - Running setup.py (path:/tmp/pip-gOJTz6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:47:41 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)) 19:47:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:47:41 INFO - Running setup.py (path:/tmp/pip-oURRBA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:47:41 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)) 19:47:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:47:41 INFO - Running setup.py (path:/tmp/pip-At2G_s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:47:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:47:41 INFO - Running setup.py (path:/tmp/pip-v1CxbV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:47:41 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)) 19:47:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:47:41 INFO - Running setup.py (path:/tmp/pip-5gdOgC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:47:41 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)) 19:47:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:47:41 INFO - Running setup.py (path:/tmp/pip-rTTrPR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:47:42 INFO - Running setup.py (path:/tmp/pip-rOgJSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:47:42 INFO - Running setup.py (path:/tmp/pip-K4eqa3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:47:42 INFO - Running setup.py (path:/tmp/pip-lFJj01-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:47:42 INFO - Running setup.py (path:/tmp/pip-LOoVEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:47:42 INFO - Running setup.py (path:/tmp/pip-r_LFb6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:47:42 INFO - Running setup.py (path:/tmp/pip-xyb2ob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:47:42 INFO - Running setup.py (path:/tmp/pip-JiejrI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:47:42 INFO - Running setup.py (path:/tmp/pip-VPRLub-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:47:42 INFO - Running setup.py (path:/tmp/pip-fnCFqI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:47:42 INFO - Running setup.py (path:/tmp/pip-9qcZb4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:47:42 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)) 19:47:42 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)) 19:47:42 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)) 19:47:42 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)) 19:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:47:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:44 INFO - Downloading blessings-1.5.1.tar.gz 19:47:44 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 19:47:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:47:44 INFO - Installing collected packages: blessings 19:47:44 INFO - Running setup.py install for blessings 19:47:44 INFO - Successfully installed blessings 19:47:44 INFO - Cleaning up... 19:47:44 INFO - Return code: 0 19:47:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:47:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:47:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:47:44 INFO - Reading from file tmpfile_stdout 19:47:44 INFO - Current package versions: 19:47:44 INFO - argparse == 1.2.1 19:47:44 INFO - blessings == 1.5.1 19:47:44 INFO - blobuploader == 1.2.4 19:47:44 INFO - docopt == 0.6.1 19:47:44 INFO - manifestparser == 1.1 19:47:44 INFO - mozInstall == 1.12 19:47:44 INFO - mozcrash == 0.16 19:47:44 INFO - mozdebug == 0.1 19:47:44 INFO - mozdevice == 0.48 19:47:44 INFO - mozfile == 1.2 19:47:44 INFO - mozhttpd == 0.7 19:47:44 INFO - mozinfo == 0.9 19:47:44 INFO - mozleak == 0.1 19:47:44 INFO - mozlog == 3.1 19:47:44 INFO - moznetwork == 0.27 19:47:44 INFO - mozprocess == 0.22 19:47:44 INFO - mozprofile == 0.28 19:47:44 INFO - mozrunner == 6.11 19:47:44 INFO - mozscreenshot == 0.1 19:47:44 INFO - mozsystemmonitor == 0.0 19:47:44 INFO - moztest == 0.7 19:47:44 INFO - mozversion == 1.4 19:47:44 INFO - psutil == 3.1.1 19:47:44 INFO - requests == 1.2.3 19:47:44 INFO - wsgiref == 0.1.2 19:47:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:44 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 0x7f57a7833f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf840>, '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 0x253c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253cb60>, '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': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', '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 19:47:44 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 19:47:45 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 19:47:45 INFO - Using env: {'DISPLAY': ':0', 19:47:45 INFO - 'HOME': '/home/cltbld', 19:47:45 INFO - 'LANG': 'en_US.UTF-8', 19:47:45 INFO - 'LANGUAGE': 'en_US:en', 19:47:45 INFO - 'LOGNAME': 'cltbld', 19:47:45 INFO - 'MAIL': '/var/mail/cltbld', 19:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:45 INFO - 'MOZ_NO_REMOTE': '1', 19:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:45 INFO - 'NO_EM_RESTART': '1', 19:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:45 INFO - 'SHELL': '/bin/bash', 19:47:45 INFO - 'SHLVL': '1', 19:47:45 INFO - 'TERM': 'linux', 19:47:45 INFO - 'TMOUT': '86400', 19:47:45 INFO - 'USER': 'cltbld', 19:47:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', 19:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:45 INFO - '_': '/tools/buildbot/bin/python'} 19:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:45 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)) 19:47:45 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)) 19:47:45 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)) 19:47:45 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)) 19:47:45 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)) 19:47:45 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)) 19:47:45 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)) 19:47:45 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)) 19:47:45 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)) 19:47:45 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)) 19:47:45 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)) 19:47:45 INFO - Cleaning up... 19:47:45 INFO - Return code: 0 19:47:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:45 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 0x7f57a7833f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf840>, '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 0x253c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253cb60>, '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': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', '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 19:47:45 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 19:47:45 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 19:47:45 INFO - Using env: {'DISPLAY': ':0', 19:47:45 INFO - 'HOME': '/home/cltbld', 19:47:45 INFO - 'LANG': 'en_US.UTF-8', 19:47:45 INFO - 'LANGUAGE': 'en_US:en', 19:47:45 INFO - 'LOGNAME': 'cltbld', 19:47:45 INFO - 'MAIL': '/var/mail/cltbld', 19:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:45 INFO - 'MOZ_NO_REMOTE': '1', 19:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:45 INFO - 'NO_EM_RESTART': '1', 19:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:45 INFO - 'SHELL': '/bin/bash', 19:47:45 INFO - 'SHLVL': '1', 19:47:45 INFO - 'TERM': 'linux', 19:47:45 INFO - 'TMOUT': '86400', 19:47:45 INFO - 'USER': 'cltbld', 19:47:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', 19:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:45 INFO - '_': '/tools/buildbot/bin/python'} 19:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:45 INFO - Downloading/unpacking jsonschema 19:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:47:47 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 19:47:47 INFO - Downloading/unpacking functools32 (from jsonschema) 19:47:47 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 19:47:47 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 19:47:47 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 19:47:47 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 19:47:47 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 19:47:47 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 19:47:47 INFO - Downloading functools32-3.2.3-2.tar.gz 19:47:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:47:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:47:47 INFO - warning: no files found matching '*.txt' 19:47:47 INFO - no previously-included directories found matching 'build' 19:47:47 INFO - no previously-included directories found matching 'dist' 19:47:47 INFO - no previously-included directories found matching '.git*' 19:47:47 INFO - Installing collected packages: jsonschema, functools32 19:47:47 INFO - Running setup.py install for functools32 19:47:47 INFO - warning: no files found matching '*.txt' 19:47:47 INFO - no previously-included directories found matching 'build' 19:47:47 INFO - no previously-included directories found matching 'dist' 19:47:47 INFO - no previously-included directories found matching '.git*' 19:47:47 INFO - Successfully installed jsonschema functools32 19:47:47 INFO - Cleaning up... 19:47:47 INFO - Return code: 0 19:47:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:47 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 0x7f57a7833f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf840>, '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 0x253c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253cb60>, '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': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', '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 19:47:47 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 19:47:47 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 19:47:47 INFO - Using env: {'DISPLAY': ':0', 19:47:47 INFO - 'HOME': '/home/cltbld', 19:47:47 INFO - 'LANG': 'en_US.UTF-8', 19:47:47 INFO - 'LANGUAGE': 'en_US:en', 19:47:47 INFO - 'LOGNAME': 'cltbld', 19:47:47 INFO - 'MAIL': '/var/mail/cltbld', 19:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:47 INFO - 'MOZ_NO_REMOTE': '1', 19:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:47 INFO - 'NO_EM_RESTART': '1', 19:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:47 INFO - 'SHELL': '/bin/bash', 19:47:47 INFO - 'SHLVL': '1', 19:47:47 INFO - 'TERM': 'linux', 19:47:47 INFO - 'TMOUT': '86400', 19:47:47 INFO - 'USER': 'cltbld', 19:47:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', 19:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:47 INFO - '_': '/tools/buildbot/bin/python'} 19:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:47 INFO - Downloading/unpacking flake8 19:47:47 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 19:47:47 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 19:47:47 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 19:47:47 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 19:47:47 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 19:47:47 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 19:47:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:47:49 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 19:47:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:47:49 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 19:47:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 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 19:47:49 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 19:47:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:47:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:47:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:47:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:47:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:47:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:47:50 INFO - no previously-included directories found matching 'docs/_build' 19:47:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:47:50 INFO - Running setup.py install for pep8 19:47:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:47:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:47:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:47:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:47:50 INFO - no previously-included directories found matching 'docs/_build' 19:47:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:47:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:47:50 INFO - Cleaning up... 19:47:50 INFO - Return code: 0 19:47:50 INFO - Running post-action listener: _resource_record_post_action 19:47:50 INFO - Running post-action listener: _start_resource_monitoring 19:47:50 INFO - Starting resource monitoring. 19:47:50 INFO - ##### 19:47:50 INFO - ##### Running install step. 19:47:50 INFO - ##### 19:47:50 INFO - Running pre-action listener: _resource_record_pre_action 19:47:50 INFO - Running main action method: install 19:47:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:47:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:47:50 INFO - Reading from file tmpfile_stdout 19:47:50 INFO - Detecting whether we're running mozinstall >=1.0... 19:47:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:47:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:47:50 INFO - Reading from file tmpfile_stdout 19:47:50 INFO - Output received: 19:47:50 INFO - Usage: mozinstall [options] installer 19:47:50 INFO - Options: 19:47:50 INFO - -h, --help show this help message and exit 19:47:50 INFO - -d DEST, --destination=DEST 19:47:50 INFO - Directory to install application into. [default: 19:47:50 INFO - "/builds/slave/test-pgo"] 19:47:50 INFO - --app=APP Application being installed. [default: firefox] 19:47:50 INFO - mkdir: /builds/slave/test-pgo/build/application 19:47:50 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'] 19:47:50 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 19:48:06 INFO - Reading from file tmpfile_stdout 19:48:06 INFO - Output received: 19:48:06 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:48:06 INFO - Running post-action listener: _resource_record_post_action 19:48:06 INFO - ##### 19:48:06 INFO - ##### Running run-tests step. 19:48:06 INFO - ##### 19:48:06 INFO - Running pre-action listener: _resource_record_pre_action 19:48:06 INFO - Running main action method: run_tests 19:48:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:48:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:48:06 INFO - Python 2.7.3 19:48:06 INFO - Return code: 0 19:48:06 INFO - grabbing minidump binary from tooltool 19:48: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')]} 19:48:06 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 0x25cf840>, '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 0x253c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:48:06 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 19:48:06 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 19:48:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:48:06 INFO - Return code: 0 19:48:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:48:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:48:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:48:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:48:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:48:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:48:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:48:07 INFO - Return code: 0 19:48:07 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/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 19:48:07 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/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 19:48:07 INFO - Using env: {'DISPLAY': ':0', 19:48:07 INFO - 'HOME': '/home/cltbld', 19:48:07 INFO - 'LANG': 'en_US.UTF-8', 19:48:07 INFO - 'LANGUAGE': 'en_US:en', 19:48:07 INFO - 'LOGNAME': 'cltbld', 19:48:07 INFO - 'MAIL': '/var/mail/cltbld', 19:48:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:48:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:07 INFO - 'MOZ_NO_REMOTE': '1', 19:48:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:07 INFO - 'NO_EM_RESTART': '1', 19:48:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:48:07 INFO - 'SHELL': '/bin/bash', 19:48:07 INFO - 'SHLVL': '1', 19:48:07 INFO - 'TERM': 'linux', 19:48:07 INFO - 'TMOUT': '86400', 19:48:07 INFO - 'USER': 'cltbld', 19:48:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648', 19:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:07 INFO - '_': '/tools/buildbot/bin/python'} 19:48:07 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/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 19:48:08 INFO - mozversion application_buildid: 20160119173009 19:48:08 INFO - mozversion application_changeset: 266fae559621e55d614f52c66e95c08228aef8ca 19:48:08 INFO - mozversion application_display_name: Nightly 19:48:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:48:08 INFO - mozversion application_name: Firefox 19:48:08 INFO - mozversion application_remotingname: firefox 19:48:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:48:08 INFO - mozversion application_vendor: Mozilla 19:48:08 INFO - mozversion application_version: 46.0a1 19:48:08 INFO - mozversion platform_buildid: 20160119173009 19:48:08 INFO - mozversion platform_changeset: 266fae559621e55d614f52c66e95c08228aef8ca 19:48:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:48:08 INFO - mozversion platform_version: 46.0a1 19:48:08 INFO - using testdate: 1453261688 19:48:08 INFO - actual date: 1453261688 19:48:08 INFO - starting webserver on 'localhost:40136' 19:48:08 INFO - SUITE-START | Running 3 tests 19:48:08 INFO - TEST-START | dromaeo_css 19:48:08 INFO - operating with platform_type : linux_ 19:48:08 INFO - Initialising browser for dromaeo_css test... 19:48:08 INFO - TEST-INFO | started process 20535 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7XAF1a/profile http://localhost:40136/getInfo.html) 19:48:11 INFO - PROCESS | 20535 | 19:48:11 INFO - PROCESS | 20535 | (process:20617): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:48:12 INFO - PROCESS | 20535 | __metrics Screen width/height:1600/1200 19:48:12 INFO - PROCESS | 20535 | colorDepth:24 19:48:12 INFO - PROCESS | 20535 | Browser inner width/height: 1024/697 19:48:12 INFO - PROCESS | 20535 | __metrics 19:48:12 INFO - PROCESS | 20535 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:48:13 INFO - TEST-INFO | 20535: exit 0 19:48:13 INFO - Browser initialized. 19:48:13 INFO - Running cycle 1/1 for dromaeo_css test... 19:48:13 INFO - TEST-INFO | started process 20666 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7XAF1a/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:48:13 INFO - PROCESS | 20666 | -- checkerboarding starts below -- 19:48:13 INFO - PROCESS | 20666 | RENDERTRACE 0.047909 rect red 0 0 10 10 // viewport 19:48:13 INFO - PROCESS | 20666 | RENDERTRACE 78.2079 rect brown 0 0 10 10 // page 19:48:13 INFO - PROCESS | 20666 | RENDERTRACE 78.2298 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 19:48:13 INFO - PROCESS | 20666 | Checkerboarded for 1 frames (82.7179 ms), 100 peak, 1 severity. 19:48:14 INFO - PROCESS | 20666 | 19:48:14 INFO - PROCESS | 20666 | (process:20725): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:48:25 INFO - PROCESS | 20666 | RSS: Main: 150200320 19:48:25 INFO - PROCESS | 20666 | 19:49:14 INFO - PROCESS | 20666 | 1453261754659 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] 19:51:23 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40136/tests/dromaeo/cssquery-ext.html) 19:51:24 INFO - PROCESS | 20666 | RSS: Main: 154189824 19:51:24 INFO - PROCESS | 20666 | 19:54:26 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-ext.html (next: http://localhost:40136/tests/dromaeo/cssquery-jquery.html) 19:54:27 INFO - PROCESS | 20666 | RSS: Main: 150630400 19:54:27 INFO - PROCESS | 20666 | 19:57:28 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40136/tests/dromaeo/cssquery-mootools.html) 19:57:29 INFO - PROCESS | 20666 | RSS: Main: 150638592 19:57:29 INFO - PROCESS | 20666 | 20:00:31 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40136/tests/dromaeo/cssquery-prototype.html) 20:00:31 INFO - PROCESS | 20666 | RSS: Main: 150409216 20:00:31 INFO - PROCESS | 20666 | 20:03:34 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40136/tests/dromaeo/cssquery-yui.html) 20:03:34 INFO - PROCESS | 20666 | RSS: Main: 150970368 20:03:34 INFO - PROCESS | 20666 | 20:06:37 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-yui.html (next: http://localhost:40136/tests/dromaeo/cssquery-dojo.html) 20:06:37 INFO - PROCESS | 20666 | RSS: Main: 153407488 20:06:37 INFO - PROCESS | 20666 | 20:06:37 INFO - PROCESS | 20666 | __start_tp_report 20:06:37 INFO - PROCESS | 20666 | _x_x_mozilla_page_load 20:06:37 INFO - PROCESS | 20666 | _x_x_mozilla_page_load_details 20:06:37 INFO - PROCESS | 20666 | |i|pagename|runs| 20:06:37 INFO - PROCESS | 20666 | |0;dojo.html;3177.85699643516;3184.968150318497;3209.614846218454;3228.6287076986155;3230.0794273632014;5099.158638824599;5223.164293713006;5296.735163241837;5300.575953923687;5303.840884773454;5280.788768449257;5309;5415.214793854899;5485.61600687952;5498.80754173604;4839.4434640016325;4890.290907818364;4930.841252305705;4945.530174633404;4971.850844474671;4805.447373552051;4858.635602329822;4908.484609116045;4980.9252861207115;5013.924791128136;4741.762911854394;4823.493533179036;4909.189983652693;4933.580645645125;4955.083309587738;4813.927791083137;4844.32179494871;4901.852944411673;4913.459519452857;4929.605631549467;4825.20384136617;4848.10310092634;4854.514548545152;4858.975705121452;4859.757012149414;5052.0906236877345;5125.410577783566;5159.896802063938;5259.184826351921;5267.3679158500845;5706.3722990471015;5739.856503587402;5742.655440673573;5748.9651862664705;5749.396313387076;5710.885782284373;5767.307923049261;5773.191753154561;5778.479936805707;5780.595358324919;5214.348206474191;5308.840734777963;5308.946910530923;5325.813596524103;5365.919511207335;5805.82582522525;5881.441263080001;5887.76448942046;5902.203202567598;5939.673317967553;5628.465295796975;5633.126865335879;5648.15277708347;5650.604457687922;5651.237082993744;5615.9157612635845;5687.345955215121;5705.486506214461;5725.656460612293;5742.684152371576;5625.353084395265;5675.489205971482;5680.204771332017;5681.460261275172;5731.684757338387;5633.183188437653;5683.346415162227;5688.829335119953;5695.145728140729;5698.17376480408;4358.411614432074;4395.472543294825;4423.756693381831;4446.088551846864;4492.505824359318;3952.091019065631;3952.308346039489;3954.1498577805332;3997.2405243003736;3999.7200195986584;5367.114426119647;5370.113931201387;5391.272178255886;5393.2449457076045;5400.405955344909;5574.386817450159;5644.8871022579315;5805.651660900275;5808.88382232353;5899.967505686488;5357.651752636144;5377.166539186433;5383.623146379794;5384.946150538444;5408.13469844823;4754.334393184957;4797.520247975244;4803.855884323476;4804.375431193923;4856.757162141949;5843.444872737083;5928.258967629046;5936.1392598073035;5970.283565972024;6019.398060193946;5689.089745640677;5694.259746232963;5696.287964004499;5700.287464066992;5701.857453563694;5827.155062515996;5889;5890.646561206341;5902.1146827976145;5907.91138132937;5575.721213939368;5628.521575665951;5694.117411801178;5768.394318596655;5778.104393818965;5758.452946970031;5758.654480731169;5762.510186634183;5773.509251713652;5783.913241301299;5624.437556244343;5626.409227031103;5626.578006649435;5636.210930469655;5647.774089036392;5520.91718624229;5536.557075434036;5588.888222235451;5620.437956204511;5624.381318054929;5519.668819870821;5528.585356098229;5544.75048622821;5548;5556.749946252509;5571.888562228652;5618.185363122406;5635.887282254414;5670.319561652628;5677.205191273142;5380.273663055594;5438.15708565173;5533.418991006048;5539.086050801573;5636.689982051026 20:06:37 INFO - PROCESS | 20666 | |1;ext.html;524.9895002099958;527.891782184652;528.0574175097452;544.0234778572462;547.8904219156167;34925.65074349256;35674.643253567454;35767.463488047666;35894.46158307628;35970;39141.41287880684;39289;39485;39514.209715805664;39761.74533534542;8499.490030598168;8842.585186370183;8920.643174273022;8940.418872773282;8944.373893827435;8512.574371281411;8664.046954834963;8673.739787806377;8698.869516957251;8718.782030449225;8730.345224108218;8753.824923501526;8777.297816174723;8800.603972821207;8840.33697472689;8645.610947507346;8684.60919258635;8687.435316704426;8695.956520217422;8746.34402419821;8636.740897773077;8706.608202630898;8756.080611535825;8825.382223244376;8844.027157012724;38642.42036369457;38676.80661596702;39042.41436378456;39084.41373379373;39105.21789564193;2900.1734505665786;3067.815931044122;3223.9355212895844;3245.694284236906;3318.3363327334628;28160.577591336147;28815;28837.71162288371;29092.27269318263;29212.561811572843;3706.221693444353;3745.3445647011936;3804.5434547854156;3838.42423636454;3975.403689446577;190266;192489;193192;193256.0337198305;193443;51122;52237.47762522402;54538.72730636322;54880.72559637256;54901.45098549043;59287.03564821742;61064.694676526335;61182.38817611856;61242;61422.69288653528;14271.928640356939;14463;14489.347979340955;14503.057301275383;14545;11037.282576632493;11090.279131856403;11103.555857765761;11106.111511079256;11108.111351091893;18203.726944095848;18332.725009124875;18341.633167336844;18412.079396030145;19154.138063787163;7041.366277035091;7381.188069312371;7401.222871598512;7413.073365829271;7432.182459929403;855.5508358112041;903.6340282185726;960.1550635440767;986.8717066781272;1027.9977022403098;27593.58609620857;27992.72007279942;28223.717762822518;28440;28475.857620712177;957.1194501059042;995.4425521707867;1003.508280942333;1056.0970370333407;1085.647164671485;12825.935870320774;12962.611121666365;12970;13042.934785326013;13109.410076546388;296665;304882;305320;305750;306126;49395.259071113964;49444;49700.75149624229;49721.25418118731;49854.750726246864;1264.7217612125319;1288.9419976101099;1295.7389355574583;1301.219268438929;1307.5946456598485;25076.62385064262;25695.87152064228;25961.740382596687;26255;26542.469150616493;41759.373609395276;41778;41805.79097104495;42011.73964781062;42081.57918420777;296455;298136;300050;301798;301997;29746.702532975258;31133.377332453678;31293.687063129077;31537.684623154393;31956.201094971882;36706.08234794151;37980.62019379771;39254.2149157021;39739.80130099331;39882.20235595214;33207.15350223547;33398.16504587405;33756.49365259474;34437.311253774285;34572.30855382828;33736.66263337335;34098.31803363968;34322.656773432944;34687.13282167865;34702.30595388129;33363.124497274766;34267;34474.482882756274;34513.82743086369;34551.30897382089;26717.866410667822;28218.576721349607;28637.713622863506;28780.42439151247;28878.855605722678;24080.518389631758;24202.636960445256;24252.272431827074;24342;24531.632025519273 20:06:37 INFO - PROCESS | 20666 | |2;jquery.html;366.42288395776654;366.60223657331795;367.8142538018301;368.2616354209809;371.780649416844;13794.31028448576;14284.500042498514;15682.92158539207;16498.83501164988;17175.828241717565;15401;15618.609534761608;15859.603509912258;15968.680626387466;15993.600159995976;4941.752912354385;5344.946550534503;5354.330708661418;5362.570994320445;5381.865453363677;5101.795928162887;5225.555827754645;5298.973505132488;5308.708021058859;5327.653702509325;5094.490550944913;5277.973610131963;5286.524212820846;5304.310439642861;5321.36143662761;5468.824202796378;5504.256925315091;5515;5536.723163841812;5539.8892022159735;5360.008398446261;5363.410024897258;5365.946340536584;5367.409584945653;5379.193121031837;12628.368581570976;14034.368453419518;16934.3226270949;19669.803301966942;19698.310559130507;2007.217185297735;2042.9795702042939;2090.2684060578827;2119.7880211978677;2190.5290362572123;9037.593308301142;9268.675596354162;9416.529173541296;9623.711288661352;9806.16647584956;1754.8508376787988;1768.6109056007658;1777.6711308407857;1789.0696837644482;1797.3709201779272;49875;50673.74663126661;51136.48863511317;55343.72328138374;58065;9632.133108020313;9878.160356369644;10164.796704065877;10227.795444091225;10244.436555989343;13179.472821087049;13316.134451260637;13363;13365.198088114745;13386.19682819034;7173.856522869513;7243.167035790846;7270.600116993616;7275.381592564586;7299.41604671625;6900.171979362509;6940.201876784134;6954.652267386711;7084.079069720903;7139.571625702474;4284;4431.113777244564;4493.213687604656;4517.909641807146;4540.72755634663;1801.1714611278696;1812.5649844037337;1816.97274540882;1817.736428217901;1845.8984755838558;855.7347222361088;865.0674214413144;877.5480627476854;877.6796469288792;968.8449848024424;15416.533354663425;15561.377544898078;15649.84350156484;15851.841481585037;16055.598610034609;869.7825543614097;905.6830109461636;907.0249481807084;952.8332541805295;965.6764983730388;9400.529973501298;9487;9572.808543829224;9603.231741460666;9635.22918166545;448464;455825;465455;467613;471916;65397;68055.65972170107;69458.30541694518;69719.3028069723;71910;1027.4503140819625;1045.2839804733783;1047.910927571165;1047.9423631700329;1061.1616822710128;14471.421143154155;14747.55757327282;14775.556733298019;14798.408063677763;14849.40602375936;29886.85056574703;30075;30689.846550767103;33275.500867486524;33755.493667595496;37965;39665.40501892416;40165.19669606533;42341.576584233764;42458.363124553776;7177.318154775288;7259.274072592699;7307.525010874276;7375.557466552024;7377.5204611700065;10607.787844242917;10826.67519974402;10945.83581246298;11053.226274160732;11145.164112691418;3008.0374280230117;6619.801405957829;9241.445513269226;9491.860976682843;9496.382735122195;9452.905470945203;9611.327207095435;9612.855807162758;9633.470159141314;9878;9613.182879455324;9717.9028209717;9776.657816976372;9937.254705896941;9993.200543956611;7432.21961694036;7587.203343648837;7607.961960190164;7694.307512323918;7743.883841742266;9879.259055571005;10013.148882345082;10129.139023182817;10237.181025517792;10267.794644107225 20:06:37 INFO - PROCESS | 20666 | |3;mootools.html;1443.451488434395;1444.6605047813766;1571;1726.4938510487632;1735.3058776489395;7433.145188303347;7523.247675232474;7586.089669239699;7749.728759493419;7894.407919406053;7941.841163176733;7944.086430060544;7968.601569921495;8058.476199047058;8074.91925080749;2380.440596459835;2387.295747754408;2406.867622280774;2409.819263555232;2418.141559746291;2367.1005018093188;2368.14746691191;2371.3241726108063;2377.940551486218;2418.2140804238607;2217.6008318502663;2244.1135751378197;2256.717910261217;2272.534130503251;2282.281081459335;2327.5810354136247;2334.7315058768204;2351.5767161910935;2356.8703721295324;2367.5856725073045;2268.4215525041172;2269.6028195065796;2270.591293567157;2274.65880117982;2278.7835155660187;7734.535927844291;7801.0638723352995;7809.062912450542;7819.29626333627;7821.100573434071;4859.586935110485;4990.625703072248;4990.775415106329;5021.297018417425;5025.1708468102715;3164.5886034815326;3206.7113959743733;3249.057773245756;3258.234314935988;3264.689854463822;999.3703966501058;1003.8745156855393;1025.9945253651388;1051.9474026298653;1957.354073155855;10534.78930421395;10543.84184237237;10561.996610322007;10620.256582039261;10656.04095631397;4379.299312110111;4429.202743506135;4498;4620.884477888079;4667.929981050287;8553.23020928107;8636.438631488933;8638.17937295956;8654.610542525601;8697.173768491983;4891.55975962158;4910;4914.827981020719;4926.285688575136;4928.975355123202;4515.864524064284;4516.187086324428;4526.88682782933;4569.725816451024;4570.314452832035;3475.270193259393;3604.3512167810045;3611.620779818134;3614.801185934799;3617.8552857885916;1072.9141668666489;1094.1301665176204;1104.0725790336155;1106.5573770491867;1133.7811852258856;1256.7109564800148;1270.955516556916;1278.2458349573797;1331.6870535424168;1334.5796074236584;7308.96345518269;7364.189939106694;7374.594397308092;7411;7413.2957369049855;997.2072202598952;1030.6959446963165;1092.983605245922;1098.4013712526692;1099.5052226498108;5566.888662226733;5638.802641907596;5650.26546548946;5682.232898558642;5699.8860022800145;8796;9138.406003609743;9167.26661867049;9260.861087083698;9595.088466595662;9196.402233854778;9235.307351948632;9271;9289.303302252358;9337.579808908615;7231.819204519824;7324.571708516788;7381.926180738231;7411.5553066816165;7518.323350898336;7000.684969176501;7067;7077.327653872874;7084.752033678797;7087.539309944837;7960.6417711201975;8006.079300880473;8117.10711821711;8154.38842086834;8259.545724985184;8000.83998320042;8330.916690833257;8347.707830225912;8380.916190838014;8479.448835825651;6958.582485050711;6960.408365289007;6984.678801122436;7116.074910261633;7130.322619351154;7535.24647535264;7548.66031028616;7564.773056808304;7585.734499292498;7646.694132234648;6951.721931122698;7079.752208672672;7091.716331346688;7243.130824301117;7476.813079673052;7070.434365250665;7092.609906454988;7108.9289107110335;7176.390006849268;7216.747413840701;7106.502544821813;7122.60825654594;7131.679074441558;7185;7186.065811444479;6471.288158302489;6501;6503.6097834130105;6518.837029074121;6529.444997175293;6615;6637.53537252407;6639.767608133692;6641.402273795382;6649.501287403561 20:06:37 INFO - PROCESS | 20666 | |4;prototype.html;347.5308333749439;352.17942194686384;352.3200223568513;356.8572570971612;358.7488757869492;6237.064440333952;6240.4695600873865;6316.831386193551;6355.205599300093;6466.612003279794;6233.438990490855;6248.218972628421;6274.184356033721;6285.371462853713;6314.810555683337;4766.833160839371;4774.925641730618;4778;4800.967791924744;4806.3511425957395;4763.333133361332;4773.64197685175;4778.54603812639;4779.665423420362;4786.808527658889;4639.860804175863;4710.411198600175;4740.502247264039;4742.241241401376;4759.071980963713;4688.991866748665;4692.202325604655;4717.080169366957;4730.881727956794;4748.6438517111355;4083.2650122977852;4090.6931980101613;4109.383592461125;4110.424540564323;4112.691548133872;5994;6009.939900601025;6011.669358185298;6014.609050411709;6018.879622407571;5403.78384864605;5576.86057848553;5587;5587.776488940438;5594.356648985378;6622.1722284714415;6642;6645.102911106987;6646.700898459581;6658.400743933069;4574.473935497427;4578.9771051144535;4579.496255411902;4584.518625544303;4585.151746926829;6775.864482710367;6875.07186529817;6949.756758513478;6957.304269573053;6960.3387678171;4680.110778951988;4680.7191568506;4687.39063921688;4688.413948256468;4694.36626055485;4726.787294571753;4741.312509686145;4745.193317136095;4746.525347465225;4752.667313288037;5484.232207490954;5488.7530061147345;5489.615726899079;5513.393526712059;5515.641483303572;6529.902051469232;6666.166729158856;6668.633225172662;6673.699683514254;6675.86648267032;1639.434395133677;1657.1962598139892;1689.1469807747255;1691.5432833134985;1692.5430133863788;1106.9391183484825;1124.0445621221895;1126.9605563805228;1128.3173679923693;1140.3727949627837;6125.693715314216;6230.7819226326865;6244.1570387997035;6254.781082662085;6259.311475737665;6708.698108585126;6726.899096513556;6753.08833307507;6755.3582409671;6762.69567869447;6054.212952316258;6200.81397558074;6202.162708034448;6205.689715514206;6214.223222097238;3649.59854416014;3677.3380791457794;3678.742488025866;3679.5032670589662;3684.613115622875;7076.32774886385;7084.043654106733;7091.25541818112;7092.751753688596;7108.928910710827;6900;6901.378875901193;6935.583864968017;6945.40964018054;6957.79126626202;7191.460640451987;7229.8554028919125;7246.130464344313;7260.23767504415;7305.780826575211;6846.726130954706;6883.690233939585;6920.515563910478;6925.445964322741;6944.0278361030505;6779.880800977571;6784.76253331131;6846.452283817183;6857.759978400732;6879.346462086094;7203.8559228816175;7222.422206223595;7232.710691572278;7256.45576581769;7266.237045110399;4541.84103556374;4618.676692631483;4629.097326021528;4635.3278774578175;4639.420072490939;6811.182658080864;6927.965360173167;6954.269801670752;6957.617331046841;6976.337247961435;6788.947713104477;6802.727890884309;6804.96597517029;6811.012403201409;6832.829179270558;6748.69630866622;6803.829904252433;6804.625745583842;6808.523403361717;6825.761098361533;6452.838679033061;6616.933830661632;6633.071370008299;6636.203655561363;6657.3342665733035;6765.627890466071;6812.965935170292;6833.384995350442;6843.863122737617;6857.588544687334;6623.668816559057;6645.435138013323;6651.16860392451;6668.233153187251;6675.632840193836 20:06:37 INFO - PROCESS | 20666 | |5;yui.html;830.9709160179395;837.6272558711375;838.0488145954344;844.6621351459415;848.7581039403772;12691.61925142246;12702.110852240347;12749.490020399173;12785.488580456771;12809.423575939081;12924.483020679185;12952.093353465261;12959.35203239839;12990.090693651448;12992.870071299285;645.4062262718298;659.7328082126746;796.3111908199423;806.2864365036926;810.1007881251805;793.773774474275;796.6853093028251;803.5941849366062;805.3557154276584;810.6676262732251;826.4627991805314;838.4172999765166;841.3563623827777;842.2924743215698;847.7117779954814;829.701307529292;837.9036410812773;841.6086519768306;842.1788755962948;842.7808769719855;620.2649859916014;621.0435928669888;621.7637297826797;621.9968900155516;622.0296337713182;12896;13025.088243822936;13123.409446574831;13273.137246078973;13294.40175192109;12921.741565168739;13183.274919879403;13302.60092197226;13334.599962001155;13336.466541338335;10113.544890479947;10343.896561034444;10583.523741431654;10591.94704026475;10607.416592087433;3583.6953858922025;3674.210044840372;3674.4488326751202;3761.0785357587292;3762.9623703762886;45163.32255016177;45542;45702.77148614236;45898.311525327146;45959.77020114911;9320.487373194404;9343.813123737624;9460.57427415768;9562.900266469445;9642.228621710246;18651.533711657044;18675.15961781723;18678.719819202724;18812.435626931216;18846.43460696181;7578;7600.46796724224;7728.729494467667;7996.80007999793;8011.7997050073045;4035.53591337;4112.712110152261;4125.154343359604;4135.669146468275;4149.564295748964;3140.4975203967256;3153.385089907492;3160.4943209086896;3163.6994485523837;3178.078357276364;536.549298589187;557.6208178438619;561.7556362982034;573.5411670663452;574.1158615731727;513.9614528910272;532.0609124894564;559.6642014791092;563.9182318563785;614.9269524679373;8059.798505037421;8204.466709663853;8208.671653133928;8229.177082291722;8419.83160336802;528.7646997086337;542.3735585398871;581.058684930407;702.2731472925498;711.4841739738752;3832.2718683450057;3925.097227637659;3931.1154990126993;3994.660453861396;4020.8793736187963;54702.452975469736;55218.44781552214;57033.42966570364;58449.70775146097;58586.7070664644;47159.76420117946;47491;47607.28589071167;52593.47406525886;54535;45373.773131134796;46461.76769116201;46658.30012549814;47706.5229347709;47844.9999999993;8604.956975215084;8793.472391656522;8803.33974951894;8828.117188281121;8828.558572071242;32403.675963240064;32730;33093.17267068342;33641.46764589781;33772.662273376955;38613.80693096516;42943.355849662905;43007.569924300355;43152.784236078616;43923.34114988214;11153.721156970816;11449.484773185393;11476.655700329004;11773;11988.340641264815;11994.400279985792;12025.579104731642;12439.564615238423;12882.742345153232;13061.934690326867;10294.536745846304;11399.772004560029;11426.2001659883;11539.365334906324;11690.278358937681;10924.945375273073;11671.416429178338;11806.704832378915;11830.11274154459;12091.395430228278;11337.829932551183;11427.828582571101;11568.363739994382;11687.18189726711;11718.361418936625;8744.341196092457;8855.690050848189;8903.866442003504;8943.284537236876;9203.493807840632;8932.821343572961;9051.773705657148;9902.798291485577;10015.599376024877;10021.74945626336 20:06:37 INFO - PROCESS | 20666 | __end_tp_report 20:06:37 INFO - PROCESS | 20666 | __start_cc_report 20:06:37 INFO - PROCESS | 20666 | _x_x_mozilla_cycle_collect,307 20:06:37 INFO - PROCESS | 20666 | __end_cc_report 20:06:37 INFO - PROCESS | 20666 | __startTimestamp1453262797727__endTimestamp 20:06:37 INFO - PROCESS | 20666 | 20:06:37 INFO - PROCESS | 20666 | ------- Summary: start ------- 20:06:37 INFO - PROCESS | 20666 | Number of tests: 6 20:06:37 INFO - PROCESS | 20666 | 20:06:37 INFO - PROCESS | 20666 | [#0] dojo.html Cycles:165 Average:5315.59 Median:5539.09 stddev:587.66 (10.6%) stddev-sans-first:565.03 20:06:37 INFO - PROCESS | 20666 | Values: 3177.9 3185.0 3209.6 3228.6 3230.1 5099.2 5223.2 5296.7 5300.6 5303.8 5280.8 5309.0 5415.2 5485.6 5498.8 4839.4 4890.3 4930.8 4945.5 4971.9 4805.4 4858.6 4908.5 4980.9 5013.9 4741.8 4823.5 4909.2 4933.6 4955.1 4813.9 4844.3 4901.9 4913.5 4929.6 4825.2 4848.1 4854.5 4859.0 4859.8 5052.1 5125.4 5159.9 5259.2 5267.4 5706.4 5739.9 5742.7 5749.0 5749.4 5710.9 5767.3 5773.2 5778.5 5780.6 5214.3 5308.8 5308.9 5325.8 5365.9 5805.8 5881.4 5887.8 5902.2 5939.7 5628.5 5633.1 5648.2 5650.6 5651.2 5615.9 5687.3 5705.5 5725.7 5742.7 5625.4 5675.5 5680.2 5681.5 5731.7 5633.2 5683.3 5688.8 5695.1 5698.2 4358.4 4395.5 4423.8 4446.1 4492.5 3952.1 3952.3 3954.1 3997.2 3999.7 5367.1 5370.1 5391.3 5393.2 5400.4 5574.4 5644.9 5805.7 5808.9 5900.0 5357.7 5377.2 5383.6 5384.9 5408.1 4754.3 4797.5 4803.9 4804.4 4856.8 5843.4 5928.3 5936.1 5970.3 6019.4 5689.1 5694.3 5696.3 5700.3 5701.9 5827.2 5889.0 5890.6 5902.1 5907.9 5575.7 5628.5 5694.1 5768.4 5778.1 5758.5 5758.7 5762.5 5773.5 5783.9 5624.4 5626.4 5626.6 5636.2 5647.8 5520.9 5536.6 5588.9 5620.4 5624.4 5519.7 5528.6 5544.8 5548.0 5556.7 5571.9 5618.2 5635.9 5670.3 5677.2 5380.3 5438.2 5533.4 5539.1 5636.7 20:06:37 INFO - PROCESS | 20666 | 20:06:37 INFO - PROCESS | 20666 | [#1] ext.html Cycles:180 Average:42842.48 Median:34561.81 stddev:70744.10 (204.7%) stddev-sans-first:70871.20 20:06:37 INFO - PROCESS | 20666 | Values: 525.0 527.9 528.1 544.0 547.9 34925.7 35674.6 35767.5 35894.5 35970.0 39141.4 39289.0 39485.0 39514.2 39761.7 8499.5 8842.6 8920.6 8940.4 8944.4 8512.6 8664.0 8673.7 8698.9 8718.8 8730.3 8753.8 8777.3 8800.6 8840.3 8645.6 8684.6 8687.4 8696.0 8746.3 8636.7 8706.6 8756.1 8825.4 8844.0 38642.4 38676.8 39042.4 39084.4 39105.2 2900.2 3067.8 3223.9 3245.7 3318.3 28160.6 28815.0 28837.7 29092.3 29212.6 3706.2 3745.3 3804.5 3838.4 3975.4 190266.0 192489.0 193192.0 193256.0 193443.0 51122.0 52237.5 54538.7 54880.7 54901.5 59287.0 61064.7 61182.4 61242.0 61422.7 14271.9 14463.0 14489.3 14503.1 14545.0 11037.3 11090.3 11103.6 11106.1 11108.1 18203.7 18332.7 18341.6 18412.1 19154.1 7041.4 7381.2 7401.2 7413.1 7432.2 855.6 903.6 960.2 986.9 1028.0 27593.6 27992.7 28223.7 28440.0 28475.9 957.1 995.4 1003.5 1056.1 1085.6 12825.9 12962.6 12970.0 13042.9 13109.4 296665.0 304882.0 305320.0 305750.0 306126.0 49395.3 49444.0 49700.8 49721.3 49854.8 1264.7 1288.9 1295.7 1301.2 1307.6 25076.6 25695.9 25961.7 26255.0 26542.5 41759.4 41778.0 41805.8 42011.7 42081.6 296455.0 298136.0 300050.0 301798.0 301997.0 29746.7 31133.4 31293.7 31537.7 31956.2 36706.1 37980.6 39254.2 39739.8 39882.2 33207.2 33398.2 33756.5 34437.3 34572.3 33736.7 34098.3 34322.7 34687.1 34702.3 33363.1 34267.0 34474.5 34513.8 34551.3 26717.9 28218.6 28637.7 28780.4 28878.9 24080.5 24202.6 24252.3 24342.0 24531.6 20:06:37 INFO - PROCESS | 20666 | 20:06:37 INFO - PROCESS | 20666 | [#2] jquery.html Cycles:180 Average:24824.43 Median:27884.12 stddev:75481.99 (270.7%) stddev-sans-first:75671.40 20:06:37 INFO - PROCESS | 20666 | Values: 366.4 366.6 367.8 368.3 371.8 13794.3 14284.5 15682.9 16498.8 17175.8 15401.0 15618.6 15859.6 15968.7 15993.6 4941.8 5344.9 5354.3 5362.6 5381.9 5101.8 5225.6 5299.0 5308.7 5327.7 5094.5 5278.0 5286.5 5304.3 5321.4 5468.8 5504.3 5515.0 5536.7 5539.9 5360.0 5363.4 5365.9 5367.4 5379.2 12628.4 14034.4 16934.3 19669.8 19698.3 2007.2 2043.0 2090.3 2119.8 2190.5 9037.6 9268.7 9416.5 9623.7 9806.2 1754.9 1768.6 1777.7 1789.1 1797.4 49875.0 50673.7 51136.5 55343.7 58065.0 9632.1 9878.2 10164.8 10227.8 10244.4 13179.5 13316.1 13363.0 13365.2 13386.2 7173.9 7243.2 7270.6 7275.4 7299.4 6900.2 6940.2 6954.7 7084.1 7139.6 4284.0 4431.1 4493.2 4517.9 4540.7 1801.2 1812.6 1817.0 1817.7 1845.9 855.7 865.1 877.5 877.7 968.8 15416.5 15561.4 15649.8 15851.8 16055.6 869.8 905.7 907.0 952.8 965.7 9400.5 9487.0 9572.8 9603.2 9635.2 448464.0 455825.0 465455.0 467613.0 471916.0 65397.0 68055.7 69458.3 69719.3 71910.0 1027.5 1045.3 1047.9 1047.9 1061.2 14471.4 14747.6 14775.6 14798.4 14849.4 29886.9 30075.0 30689.8 33275.5 33755.5 37965.0 39665.4 40165.2 42341.6 42458.4 7177.3 7259.3 7307.5 7375.6 7377.5 10607.8 10826.7 10945.8 11053.2 11145.2 3008.0 6619.8 9241.4 9491.9 9496.4 9452.9 9611.3 9612.9 9633.5 9878.0 9613.2 9717.9 9776.7 9937.3 9993.2 7432.2 7587.2 7608.0 7694.3 7743.9 9879.3 10013.1 10129.1 10237.2 10267.8 20:06:37 INFO - PROCESS | 20666 | 20:06:37 INFO - PROCESS | 20666 | [#3] mootools.html Cycles:180 Average:5495.65 Median:6511.22 stddev:2762.54 (42.4%) stddev-sans-first:2753.49 20:06:37 INFO - PROCESS | 20666 | Values: 1443.5 1444.7 1571.0 1726.5 1735.3 7433.1 7523.2 7586.1 7749.7 7894.4 7941.8 7944.1 7968.6 8058.5 8074.9 2380.4 2387.3 2406.9 2409.8 2418.1 2367.1 2368.1 2371.3 2377.9 2418.2 2217.6 2244.1 2256.7 2272.5 2282.3 2327.6 2334.7 2351.6 2356.9 2367.6 2268.4 2269.6 2270.6 2274.7 2278.8 7734.5 7801.1 7809.1 7819.3 7821.1 4859.6 4990.6 4990.8 5021.3 5025.2 3164.6 3206.7 3249.1 3258.2 3264.7 999.4 1003.9 1026.0 1051.9 1957.4 10534.8 10543.8 10562.0 10620.3 10656.0 4379.3 4429.2 4498.0 4620.9 4667.9 8553.2 8636.4 8638.2 8654.6 8697.2 4891.6 4910.0 4914.8 4926.3 4929.0 4515.9 4516.2 4526.9 4569.7 4570.3 3475.3 3604.4 3611.6 3614.8 3617.9 1072.9 1094.1 1104.1 1106.6 1133.8 1256.7 1271.0 1278.2 1331.7 1334.6 7309.0 7364.2 7374.6 7411.0 7413.3 997.2 1030.7 1093.0 1098.4 1099.5 5566.9 5638.8 5650.3 5682.2 5699.9 8796.0 9138.4 9167.3 9260.9 9595.1 9196.4 9235.3 9271.0 9289.3 9337.6 7231.8 7324.6 7381.9 7411.6 7518.3 7000.7 7067.0 7077.3 7084.8 7087.5 7960.6 8006.1 8117.1 8154.4 8259.5 8000.8 8330.9 8347.7 8380.9 8479.4 6958.6 6960.4 6984.7 7116.1 7130.3 7535.2 7548.7 7564.8 7585.7 7646.7 6951.7 7079.8 7091.7 7243.1 7476.8 7070.4 7092.6 7108.9 7176.4 7216.7 7106.5 7122.6 7131.7 7185.0 7186.1 6471.3 6501.0 6503.6 6518.8 6529.4 6615.0 6637.5 6639.8 6641.4 6649.5 20:06:37 INFO - PROCESS | 20666 | 20:06:37 INFO - PROCESS | 20666 | [#4] prototype.html Cycles:180 Average:5565.83 Median:6246.19 stddev:1698.70 (27.2%) stddev-sans-first:1657.70 20:06:37 INFO - PROCESS | 20666 | Values: 347.5 352.2 352.3 356.9 358.7 6237.1 6240.5 6316.8 6355.2 6466.6 6233.4 6248.2 6274.2 6285.4 6314.8 4766.8 4774.9 4778.0 4801.0 4806.4 4763.3 4773.6 4778.5 4779.7 4786.8 4639.9 4710.4 4740.5 4742.2 4759.1 4689.0 4692.2 4717.1 4730.9 4748.6 4083.3 4090.7 4109.4 4110.4 4112.7 5994.0 6009.9 6011.7 6014.6 6018.9 5403.8 5576.9 5587.0 5587.8 5594.4 6622.2 6642.0 6645.1 6646.7 6658.4 4574.5 4579.0 4579.5 4584.5 4585.2 6775.9 6875.1 6949.8 6957.3 6960.3 4680.1 4680.7 4687.4 4688.4 4694.4 4726.8 4741.3 4745.2 4746.5 4752.7 5484.2 5488.8 5489.6 5513.4 5515.6 6529.9 6666.2 6668.6 6673.7 6675.9 1639.4 1657.2 1689.1 1691.5 1692.5 1106.9 1124.0 1127.0 1128.3 1140.4 6125.7 6230.8 6244.2 6254.8 6259.3 6708.7 6726.9 6753.1 6755.4 6762.7 6054.2 6200.8 6202.2 6205.7 6214.2 3649.6 3677.3 3678.7 3679.5 3684.6 7076.3 7084.0 7091.3 7092.8 7108.9 6900.0 6901.4 6935.6 6945.4 6957.8 7191.5 7229.9 7246.1 7260.2 7305.8 6846.7 6883.7 6920.5 6925.4 6944.0 6779.9 6784.8 6846.5 6857.8 6879.3 7203.9 7222.4 7232.7 7256.5 7266.2 4541.8 4618.7 4629.1 4635.3 4639.4 6811.2 6928.0 6954.3 6957.6 6976.3 6788.9 6802.7 6805.0 6811.0 6832.8 6748.7 6803.8 6804.6 6808.5 6825.8 6452.8 6616.9 6633.1 6636.2 6657.3 6765.6 6813.0 6833.4 6843.9 6857.6 6623.7 6645.4 6651.2 6668.2 6675.6 20:06:37 INFO - PROCESS | 20666 | 20:06:37 INFO - PROCESS | 20666 | [#5] yui.html Cycles:180 Average:13567.66 Median:45800.54 stddev:15517.05 (33.9%) stddev-sans-first:15531.10 20:06:37 INFO - PROCESS | 20666 | Values: 831.0 837.6 838.0 844.7 848.8 12691.6 12702.1 12749.5 12785.5 12809.4 12924.5 12952.1 12959.4 12990.1 12992.9 645.4 659.7 796.3 806.3 810.1 793.8 796.7 803.6 805.4 810.7 826.5 838.4 841.4 842.3 847.7 829.7 837.9 841.6 842.2 842.8 620.3 621.0 621.8 622.0 622.0 12896.0 13025.1 13123.4 13273.1 13294.4 12921.7 13183.3 13302.6 13334.6 13336.5 10113.5 10343.9 10583.5 10591.9 10607.4 3583.7 3674.2 3674.4 3761.1 3763.0 45163.3 45542.0 45702.8 45898.3 45959.8 9320.5 9343.8 9460.6 9562.9 9642.2 18651.5 18675.2 18678.7 18812.4 18846.4 7578.0 7600.5 7728.7 7996.8 8011.8 4035.5 4112.7 4125.2 4135.7 4149.6 3140.5 3153.4 3160.5 3163.7 3178.1 536.5 557.6 561.8 573.5 574.1 514.0 532.1 559.7 563.9 614.9 8059.8 8204.5 8208.7 8229.2 8419.8 528.8 542.4 581.1 702.3 711.5 3832.3 3925.1 3931.1 3994.7 4020.9 54702.5 55218.4 57033.4 58449.7 58586.7 47159.8 47491.0 47607.3 52593.5 54535.0 45373.8 46461.8 46658.3 47706.5 47845.0 8605.0 8793.5 8803.3 8828.1 8828.6 32403.7 32730.0 33093.2 33641.5 33772.7 38613.8 42943.4 43007.6 43152.8 43923.3 11153.7 11449.5 11476.7 11773.0 11988.3 11994.4 12025.6 12439.6 12882.7 13061.9 10294.5 11399.8 11426.2 11539.4 11690.3 10924.9 11671.4 11806.7 11830.1 12091.4 11337.8 11427.8 11568.4 11687.2 11718.4 8744.3 8855.7 8903.9 8943.3 9203.5 8932.8 9051.8 9902.8 10015.6 10021.7 20:06:37 INFO - PROCESS | 20666 | -------- Summary: end -------- 20:06:37 INFO - PROCESS | 20666 | 20:06:38 INFO - TEST-INFO | 20666: exit 0 20:06:38 INFO - TEST-OK | dromaeo_css | took 1110324ms 20:06:38 INFO - TEST-START | kraken 20:06:38 INFO - operating with platform_type : linux_ 20:06:38 INFO - Initialising browser for kraken test... 20:06:38 INFO - TEST-INFO | started process 20909 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3mLy6Q/profile http://localhost:40136/getInfo.html) 20:06:41 INFO - PROCESS | 20909 | 20:06:41 INFO - PROCESS | 20909 | (process:20981): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:42 INFO - PROCESS | 20909 | __metrics Screen width/height:1600/1200 20:06:42 INFO - PROCESS | 20909 | colorDepth:24 20:06:42 INFO - PROCESS | 20909 | Browser inner width/height: 1024/697 20:06:42 INFO - PROCESS | 20909 | __metrics 20:06:42 INFO - PROCESS | 20909 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:06:43 INFO - TEST-INFO | 20909: exit 0 20:06:43 INFO - Browser initialized. 20:06:43 INFO - Running cycle 1/1 for kraken test... 20:06:43 INFO - TEST-INFO | started process 21030 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3mLy6Q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:44 INFO - PROCESS | 21030 | -- checkerboarding starts below -- 20:06:44 INFO - PROCESS | 21030 | RENDERTRACE 0.053245 rect red 0 0 10 10 // viewport 20:06:44 INFO - PROCESS | 21030 | RENDERTRACE 35.4784 rect brown 0 0 10 10 // page 20:06:44 INFO - PROCESS | 21030 | RENDERTRACE 35.498 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 20:06:44 INFO - PROCESS | 21030 | Checkerboarded for 1 frames (49.3177 ms), 100 peak, 1 severity. 20:06:44 INFO - PROCESS | 21030 | 20:06:44 INFO - PROCESS | 21030 | (process:21089): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:55 INFO - PROCESS | 21030 | RSS: Main: 150081536 20:06:55 INFO - PROCESS | 21030 | 20:06:57 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-beat-detection) 20:06:58 INFO - PROCESS | 21030 | RSS: Main: 150523904 20:06:58 INFO - PROCESS | 21030 | 20:07:00 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-dft) 20:07:01 INFO - PROCESS | 21030 | RSS: Main: 153874432 20:07:01 INFO - PROCESS | 21030 | 20:07:04 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-fft) 20:07:05 INFO - PROCESS | 21030 | RSS: Main: 146444288 20:07:05 INFO - PROCESS | 21030 | 20:07:07 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-oscillator) 20:07:07 INFO - PROCESS | 21030 | RSS: Main: 147697664 20:07:07 INFO - PROCESS | 21030 | 20:07:10 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40136/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:07:10 INFO - PROCESS | 21030 | RSS: Main: 147804160 20:07:10 INFO - PROCESS | 21030 | 20:07:13 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40136/tests/kraken/driver.html?testName=imaging-darkroom) 20:07:14 INFO - PROCESS | 21030 | RSS: Main: 147976192 20:07:14 INFO - PROCESS | 21030 | 20:07:17 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40136/tests/kraken/driver.html?testName=imaging-desaturate) 20:07:18 INFO - PROCESS | 21030 | RSS: Main: 149086208 20:07:18 INFO - PROCESS | 21030 | 20:07:21 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40136/tests/kraken/driver.html?testName=json-parse-financial) 20:07:21 INFO - PROCESS | 21030 | RSS: Main: 151060480 20:07:21 INFO - PROCESS | 21030 | 20:07:23 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40136/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:07:23 INFO - PROCESS | 21030 | RSS: Main: 150261760 20:07:23 INFO - PROCESS | 21030 | 20:07:25 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:07:26 INFO - PROCESS | 21030 | RSS: Main: 150999040 20:07:26 INFO - PROCESS | 21030 | 20:07:28 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:07:29 INFO - PROCESS | 21030 | RSS: Main: 150822912 20:07:29 INFO - PROCESS | 21030 | 20:07:31 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:07:32 INFO - PROCESS | 21030 | RSS: Main: 150835200 20:07:32 INFO - PROCESS | 21030 | 20:07:34 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:07:35 INFO - PROCESS | 21030 | RSS: Main: 151166976 20:07:35 INFO - PROCESS | 21030 | 20:07:36 INFO - PROCESS | 21030 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40136/tests/kraken/driver.html?testName=ai-astar) 20:07:37 INFO - PROCESS | 21030 | RSS: Main: 150401024 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | __start_tp_report 20:07:37 INFO - PROCESS | 21030 | _x_x_mozilla_page_load 20:07:37 INFO - PROCESS | 21030 | _x_x_mozilla_page_load_details 20:07:37 INFO - PROCESS | 21030 | |i|pagename|runs| 20:07:37 INFO - PROCESS | 21030 | |0;ai-astar;112;107;112;111;113;122;111;111;111;111 20:07:37 INFO - PROCESS | 21030 | |1;audio-beat-detection;153;128;156;163;132;154;157;136;164;126 20:07:37 INFO - PROCESS | 21030 | |2;audio-dft;163;165;164;163;163;164;164;175;163;164 20:07:37 INFO - PROCESS | 21030 | |3;audio-fft;77;76;74;74;74;146;73;76;73;74 20:07:37 INFO - PROCESS | 21030 | |4;audio-oscillator;97;97;149;96;99;96;144;98;97;145 20:07:37 INFO - PROCESS | 21030 | |5;imaging-gaussian-blur;110;110;110;110;110;110;109;112;110;110 20:07:37 INFO - PROCESS | 21030 | |6;imaging-darkroom;146;153;146;147;146;147;147;146;147;147 20:07:37 INFO - PROCESS | 21030 | |7;imaging-desaturate;97;96;97;98;97;96;97;97;98;100 20:07:37 INFO - PROCESS | 21030 | |8;json-parse-financial;61;62;63;64;62;62;63;63;71;59 20:07:37 INFO - PROCESS | 21030 | |9;json-stringify-tinderbox;68;68;68;67;68;69;69;68;68;68 20:07:37 INFO - PROCESS | 21030 | |10;stanford-crypto-aes;82;82;85;83;81;82;82;91;83;80 20:07:37 INFO - PROCESS | 21030 | |11;stanford-crypto-ccm;117;128;131;138;118;117;122;120;124;129 20:07:37 INFO - PROCESS | 21030 | |12;stanford-crypto-pbkdf2;135;148;148;145;145;131;144;141;145;141 20:07:37 INFO - PROCESS | 21030 | |13;stanford-crypto-sha256-iterative;70;72;69;67;68;67;67;67;67;67 20:07:37 INFO - PROCESS | 21030 | __end_tp_report 20:07:37 INFO - PROCESS | 21030 | __start_cc_report 20:07:37 INFO - PROCESS | 21030 | _x_x_mozilla_cycle_collect,766 20:07:37 INFO - PROCESS | 21030 | __end_cc_report 20:07:37 INFO - PROCESS | 21030 | __startTimestamp1453262857157__endTimestamp 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | ------- Summary: start ------- 20:07:37 INFO - PROCESS | 21030 | Number of tests: 14 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:3.81 (3.4%) stddev-sans-first:4.04 20:07:37 INFO - PROCESS | 21030 | Values: 112.0 107.0 112.0 111.0 113.0 122.0 111.0 111.0 111.0 111.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:155.00 stddev:14.75 (9.5%) stddev-sans-first:15.48 20:07:37 INFO - PROCESS | 21030 | Values: 153.0 128.0 156.0 163.0 132.0 154.0 157.0 136.0 164.0 126.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:3.65 (2.2%) stddev-sans-first:3.81 20:07:37 INFO - PROCESS | 21030 | Values: 163.0 165.0 164.0 163.0 163.0 164.0 164.0 175.0 163.0 164.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#3] audio-fft Cycles:10 Average:81.70 Median:74.00 stddev:22.63 (30.6%) stddev-sans-first:23.94 20:07:37 INFO - PROCESS | 21030 | Values: 77.0 76.0 74.0 74.0 74.0 146.0 73.0 76.0 73.0 74.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:97.00 stddev:23.65 (24.4%) stddev-sans-first:24.47 20:07:37 INFO - PROCESS | 21030 | Values: 97.0 97.0 149.0 96.0 99.0 96.0 144.0 98.0 97.0 145.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 20:07:37 INFO - PROCESS | 21030 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 112.0 110.0 110.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:2.10 (1.4%) stddev-sans-first:2.18 20:07:37 INFO - PROCESS | 21030 | Values: 146.0 153.0 146.0 147.0 146.0 147.0 147.0 146.0 147.0 147.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:97.00 stddev:1.16 (1.2%) stddev-sans-first:1.22 20:07:37 INFO - PROCESS | 21030 | Values: 97.0 96.0 97.0 98.0 97.0 96.0 97.0 97.0 98.0 100.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:3.13 (5.0%) stddev-sans-first:3.23 20:07:37 INFO - PROCESS | 21030 | Values: 61.0 62.0 63.0 64.0 62.0 62.0 63.0 63.0 71.0 59.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 20:07:37 INFO - PROCESS | 21030 | Values: 68.0 68.0 68.0 67.0 68.0 69.0 69.0 68.0 68.0 68.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.50 stddev:3.07 (3.7%) stddev-sans-first:3.23 20:07:37 INFO - PROCESS | 21030 | Values: 82.0 82.0 85.0 83.0 81.0 82.0 82.0 91.0 83.0 80.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:126.00 stddev:6.98 (5.5%) stddev-sans-first:6.87 20:07:37 INFO - PROCESS | 21030 | Values: 117.0 128.0 131.0 138.0 118.0 117.0 122.0 120.0 124.0 129.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:145.00 stddev:5.52 (3.8%) stddev-sans-first:5.18 20:07:37 INFO - PROCESS | 21030 | Values: 135.0 148.0 148.0 145.0 145.0 131.0 144.0 141.0 145.0 141.0 20:07:37 INFO - PROCESS | 21030 | 20:07:37 INFO - PROCESS | 21030 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:1.73 (2.6%) stddev-sans-first:1.69 20:07:37 INFO - PROCESS | 21030 | Values: 70.0 72.0 69.0 67.0 68.0 67.0 67.0 67.0 67.0 67.0 20:07:37 INFO - PROCESS | 21030 | -------- Summary: end -------- 20:07:37 INFO - PROCESS | 21030 | 20:07:38 INFO - TEST-INFO | 21030: exit 0 20:07:38 INFO - TEST-OK | kraken | took 59709ms 20:07:38 INFO - TEST-START | v8_7 20:07:38 INFO - operating with platform_type : linux_ 20:07:38 INFO - Initialising browser for v8_7 test... 20:07:38 INFO - TEST-INFO | started process 21317 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7ASq8X/profile http://localhost:40136/getInfo.html) 20:07:41 INFO - PROCESS | 21317 | 20:07:41 INFO - PROCESS | 21317 | (process:21388): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:07:42 INFO - PROCESS | 21317 | __metrics Screen width/height:1600/1200 20:07:42 INFO - PROCESS | 21317 | colorDepth:24 20:07:42 INFO - PROCESS | 21317 | Browser inner width/height: 1024/697 20:07:42 INFO - PROCESS | 21317 | __metrics 20:07:42 INFO - PROCESS | 21317 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:07:43 INFO - TEST-INFO | 21317: exit 0 20:07:43 INFO - Browser initialized. 20:07:43 INFO - Running cycle 1/1 for v8_7 test... 20:07:43 INFO - TEST-INFO | started process 21437 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7ASq8X/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:43 INFO - PROCESS | 21437 | -- checkerboarding starts below -- 20:07:43 INFO - PROCESS | 21437 | RENDERTRACE 0.053489 rect red 0 0 10 10 // viewport 20:07:43 INFO - PROCESS | 21437 | RENDERTRACE 35.6579 rect brown 0 0 10 10 // page 20:07:43 INFO - PROCESS | 21437 | RENDERTRACE 35.6802 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 20:07:43 INFO - PROCESS | 21437 | Checkerboarded for 1 frames (37.6761 ms), 100 peak, 1 severity. 20:07:44 INFO - PROCESS | 21437 | 20:07:44 INFO - PROCESS | 21437 | (process:21501): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:07:55 INFO - PROCESS | 21437 | RSS: Main: 150470656 20:07:55 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | Cycle 1(1): loaded http://localhost:40136/tests/v8_7/run.html (next: http://localhost:40136/tests/v8_7/run.html) 20:08:17 INFO - PROCESS | 21437 | RSS: Main: 146366464 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | __start_tp_report 20:08:17 INFO - PROCESS | 21437 | _x_x_mozilla_page_load 20:08:17 INFO - PROCESS | 21437 | _x_x_mozilla_page_load_details 20:08:17 INFO - PROCESS | 21437 | |i|pagename|runs| 20:08:17 INFO - PROCESS | 21437 | |0;Richards;171.88037126160194 20:08:17 INFO - PROCESS | 21437 | |1;DeltaBlue;190.5850962454736 20:08:17 INFO - PROCESS | 21437 | |2;Encrypt;279.6420581655481 20:08:17 INFO - PROCESS | 21437 | |3;Decrypt;5324.468085106383 20:08:17 INFO - PROCESS | 21437 | |4;RayTrace;1085.7763300760043 20:08:17 INFO - PROCESS | 21437 | |5;Earley;727.802037845706 20:08:17 INFO - PROCESS | 21437 | |6;Boyer;12658.227848101265 20:08:17 INFO - PROCESS | 21437 | |7;RegExp;40820 20:08:17 INFO - PROCESS | 21437 | |8;Splay;636.5372374283895 20:08:17 INFO - PROCESS | 21437 | |9;NavierStokes;4822.115384615385 20:08:17 INFO - PROCESS | 21437 | __end_tp_report 20:08:17 INFO - PROCESS | 21437 | __startTimestamp1453262897684__endTimestamp 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | ------- Summary: start ------- 20:08:17 INFO - PROCESS | 21437 | Number of tests: 10 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | [#0] Richards Cycles:1 Average:171.88 Median:171.88 stddev:0.00 (0.0%) 20:08:17 INFO - PROCESS | 21437 | Values: 171.9 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | [#1] DeltaBlue Cycles:1 Average:190.59 Median:190.59 stddev:0.00 (0.0%) 20:08:17 INFO - PROCESS | 21437 | Values: 190.6 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 20:08:17 INFO - PROCESS | 21437 | Values: 279.6 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | [#3] Decrypt Cycles:1 Average:5324.47 Median:5324.47 stddev:0.00 (0.0%) 20:08:17 INFO - PROCESS | 21437 | Values: 5324.5 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | [#4] RayTrace Cycles:1 Average:1085.78 Median:1085.78 stddev:0.00 (0.0%) 20:08:17 INFO - PROCESS | 21437 | Values: 1085.8 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | [#5] Earley Cycles:1 Average:727.80 Median:727.80 stddev:0.00 (0.0%) 20:08:17 INFO - PROCESS | 21437 | Values: 727.8 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | [#6] Boyer Cycles:1 Average:12658.23 Median:12658.23 stddev:0.00 (0.0%) 20:08:17 INFO - PROCESS | 21437 | Values: 12658.2 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | [#7] RegExp Cycles:1 Average:40820.00 Median:40820.00 stddev:0.00 (0.0%) 20:08:17 INFO - PROCESS | 21437 | Values: 40820.0 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | [#8] Splay Cycles:1 Average:636.54 Median:636.54 stddev:0.00 (0.0%) 20:08:17 INFO - PROCESS | 21437 | Values: 636.5 20:08:17 INFO - PROCESS | 21437 | 20:08:17 INFO - PROCESS | 21437 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 20:08:17 INFO - PROCESS | 21437 | Values: 4822.1 20:08:17 INFO - PROCESS | 21437 | -------- Summary: end -------- 20:08:17 INFO - PROCESS | 21437 | 20:08:18 INFO - TEST-INFO | 21437: exit 0 20:08:18 INFO - TEST-OK | v8_7 | took 40439ms 20:08:18 INFO - SUITE-END | took 1210s 20:08:18 INFO - Completed test suite (00:20:10) 20:08:18 INFO - Working with test: dromaeo_css 20:08:18 INFO - Generating results file: dromaeo_css 20:08:18 INFO - Working with test: kraken 20:08:18 INFO - Generating results file: kraken 20:08:18 INFO - javascript benchmark 20:08:18 INFO - Working with test: v8_7 20:08:18 INFO - Generating results file: v8_7 20:08:18 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:08:19 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:08:19 INFO - process_Request line: dromaeo_css 6855.36 graph.html#tests=[[72,64,43]] 20:08:19 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:08:19 INFO - process_Request line: kraken 1520.90 graph.html#tests=[[232,64,43]] 20:08:19 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:08:19 INFO - process_Request line: v8_7 20021.36 graph.html#tests=[[230,64,43]] 20:08:19 INFO - RETURN: dromaeo_css: 6855.36 20:08:19 INFO - RETURN: kraken: 1520.90 20:08:19 INFO - RETURN: v8_7: 20021.36 20:08:19 INFO - javascript benchmark 20:08:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3177.85699643516, 3184.968150318497, 3209.614846218454, 3228.6287076986155, 3230.0794273632014, 5099.158638824599, 5223.164293713006, 5296.735163241837, 5300.575953923687, 5303.840884773454, 5280.788768449257, 5309.0, 5415.214793854899, 5485.61600687952, 5498.80754173604, 4839.4434640016325, 4890.290907818364, 4930.841252305705, 4945.530174633404, 4971.850844474671, 4805.447373552051, 4858.635602329822, 4908.484609116045, 4980.9252861207115, 5013.924791128136, 4741.762911854394, 4823.493533179036, 4909.189983652693, 4933.580645645125, 4955.083309587738, 4813.927791083137, 4844.32179494871, 4901.852944411673, 4913.459519452857, 4929.605631549467, 4825.20384136617, 4848.10310092634, 4854.514548545152, 4858.975705121452, 4859.757012149414, 5052.0906236877345, 5125.410577783566, 5159.896802063938, 5259.184826351921, 5267.3679158500845, 5706.3722990471015, 5739.856503587402, 5742.655440673573, 5748.9651862664705, 5749.396313387076, 5710.885782284373, 5767.307923049261, 5773.191753154561, 5778.479936805707, 5780.595358324919, 5214.348206474191, 5308.840734777963, 5308.946910530923, 5325.813596524103, 5365.919511207335, 5805.82582522525, 5881.441263080001, 5887.76448942046, 5902.203202567598, 5939.673317967553, 5628.465295796975, 5633.126865335879, 5648.15277708347, 5650.604457687922, 5651.237082993744, 5615.9157612635845, 5687.345955215121, 5705.486506214461, 5725.656460612293, 5742.684152371576, 5625.353084395265, 5675.489205971482, 5680.204771332017, 5681.460261275172, 5731.684757338387, 5633.183188437653, 5683.346415162227, 5688.829335119953, 5695.145728140729, 5698.17376480408, 4358.411614432074, 4395.472543294825, 4423.756693381831, 4446.088551846864, 4492.505824359318, 3952.091019065631, 3952.308346039489, 3954.1498577805332, 3997.2405243003736, 3999.7200195986584, 5367.114426119647, 5370.113931201387, 5391.272178255886, 5393.2449457076045, 5400.405955344909, 5574.386817450159, 5644.8871022579315, 5805.651660900275, 5808.88382232353, 5899.967505686488, 5357.651752636144, 5377.166539186433, 5383.623146379794, 5384.946150538444, 5408.13469844823, 4754.334393184957, 4797.520247975244, 4803.855884323476, 4804.375431193923, 4856.757162141949, 5843.444872737083, 5928.258967629046, 5936.1392598073035, 5970.283565972024, 6019.398060193946, 5689.089745640677, 5694.259746232963, 5696.287964004499, 5700.287464066992, 5701.857453563694, 5827.155062515996, 5889.0, 5890.646561206341, 5902.1146827976145, 5907.91138132937, 5575.721213939368, 5628.521575665951, 5694.117411801178, 5768.394318596655, 5778.104393818965, 5758.452946970031, 5758.654480731169, 5762.510186634183, 5773.509251713652, 5783.913241301299, 5624.437556244343, 5626.409227031103, 5626.578006649435, 5636.210930469655, 5647.774089036392, 5520.91718624229, 5536.557075434036, 5588.888222235451, 5620.437956204511, 5624.381318054929, 5519.668819870821, 5528.585356098229, 5544.75048622821, 5548.0, 5556.749946252509, 5571.888562228652, 5618.185363122406, 5635.887282254414, 5670.319561652628, 5677.205191273142, 5380.273663055594, 5438.15708565173, 5533.418991006048, 5539.086050801573, 5636.689982051026], "unit": "score", "name": "dojo.html", "value": 5277.737358287944}, {"lowerIsBetter": false, "replicates": [524.9895002099958, 527.891782184652, 528.0574175097452, 544.0234778572462, 547.8904219156167, 34925.65074349256, 35674.643253567454, 35767.463488047666, 35894.46158307628, 35970.0, 39141.41287880684, 39289.0, 39485.0, 39514.209715805664, 39761.74533534542, 8499.490030598168, 8842.585186370183, 8920.643174273022, 8940.418872773282, 8944.373893827435, 8512.574371281411, 8664.046954834963, 8673.739787806377, 8698.869516957251, 8718.782030449225, 8730.345224108218, 8753.824923501526, 8777.297816174723, 8800.603972821207, 8840.33697472689, 8645.610947507346, 8684.60919258635, 8687.435316704426, 8695.956520217422, 8746.34402419821, 8636.740897773077, 8706.608202630898, 8756.080611535825, 8825.382223244376, 8844.027157012724, 38642.42036369457, 38676.80661596702, 39042.41436378456, 39084.41373379373, 39105.21789564193, 2900.1734505665786, 3067.815931044122, 3223.9355212895844, 3245.694284236906, 3318.3363327334628, 28160.577591336147, 28815.0, 28837.71162288371, 29092.27269318263, 29212.561811572843, 3706.221693444353, 3745.3445647011936, 3804.5434547854156, 3838.42423636454, 3975.403689446577, 190266.0, 192489.0, 193192.0, 193256.0337198305, 193443.0, 51122.0, 52237.47762522402, 54538.72730636322, 54880.72559637256, 54901.45098549043, 59287.03564821742, 61064.694676526335, 61182.38817611856, 61242.0, 61422.69288653528, 14271.928640356939, 14463.0, 14489.347979340955, 14503.057301275383, 14545.0, 11037.282576632493, 11090.279131856403, 11103.555857765761, 11106.111511079256, 11108.111351091893, 18203.726944095848, 18332.725009124875, 18341.633167336844, 18412.079396030145, 19154.138063787163, 7041.366277035091, 7381.188069312371, 7401.222871598512, 7413.073365829271, 7432.182459929403, 855.5508358112041, 903.6340282185726, 960.1550635440767, 986.8717066781272, 1027.9977022403098, 27593.58609620857, 27992.72007279942, 28223.717762822518, 28440.0, 28475.857620712177, 957.1194501059042, 995.4425521707867, 1003.508280942333, 1056.0970370333407, 1085.647164671485, 12825.935870320774, 12962.611121666365, 12970.0, 13042.934785326013, 13109.410076546388, 296665.0, 304882.0, 305320.0, 305750.0, 306126.0, 49395.259071113964, 49444.0, 49700.75149624229, 49721.25418118731, 49854.750726246864, 1264.7217612125319, 1288.9419976101099, 1295.7389355574583, 1301.219268438929, 1307.5946456598485, 25076.62385064262, 25695.87152064228, 25961.740382596687, 26255.0, 26542.469150616493, 41759.373609395276, 41778.0, 41805.79097104495, 42011.73964781062, 42081.57918420777, 296455.0, 298136.0, 300050.0, 301798.0, 301997.0, 29746.702532975258, 31133.377332453678, 31293.687063129077, 31537.684623154393, 31956.201094971882, 36706.08234794151, 37980.62019379771, 39254.2149157021, 39739.80130099331, 39882.20235595214, 33207.15350223547, 33398.16504587405, 33756.49365259474, 34437.311253774285, 34572.30855382828, 33736.66263337335, 34098.31803363968, 34322.656773432944, 34687.13282167865, 34702.30595388129, 33363.124497274766, 34267.0, 34474.482882756274, 34513.82743086369, 34551.30897382089, 26717.866410667822, 28218.576721349607, 28637.713622863506, 28780.42439151247, 28878.855605722678, 24080.518389631758, 24202.636960445256, 24252.272431827074, 24342.0, 24531.632025519273], "unit": "score", "name": "ext.html", "value": 17462.788859569504}, {"lowerIsBetter": false, "replicates": [366.42288395776654, 366.60223657331795, 367.8142538018301, 368.2616354209809, 371.780649416844, 13794.31028448576, 14284.500042498514, 15682.92158539207, 16498.83501164988, 17175.828241717565, 15401.0, 15618.609534761608, 15859.603509912258, 15968.680626387466, 15993.600159995976, 4941.752912354385, 5344.946550534503, 5354.330708661418, 5362.570994320445, 5381.865453363677, 5101.795928162887, 5225.555827754645, 5298.973505132488, 5308.708021058859, 5327.653702509325, 5094.490550944913, 5277.973610131963, 5286.524212820846, 5304.310439642861, 5321.36143662761, 5468.824202796378, 5504.256925315091, 5515.0, 5536.723163841812, 5539.8892022159735, 5360.008398446261, 5363.410024897258, 5365.946340536584, 5367.409584945653, 5379.193121031837, 12628.368581570976, 14034.368453419518, 16934.3226270949, 19669.803301966942, 19698.310559130507, 2007.217185297735, 2042.9795702042939, 2090.2684060578827, 2119.7880211978677, 2190.5290362572123, 9037.593308301142, 9268.675596354162, 9416.529173541296, 9623.711288661352, 9806.16647584956, 1754.8508376787988, 1768.6109056007658, 1777.6711308407857, 1789.0696837644482, 1797.3709201779272, 49875.0, 50673.74663126661, 51136.48863511317, 55343.72328138374, 58065.0, 9632.133108020313, 9878.160356369644, 10164.796704065877, 10227.795444091225, 10244.436555989343, 13179.472821087049, 13316.134451260637, 13363.0, 13365.198088114745, 13386.19682819034, 7173.856522869513, 7243.167035790846, 7270.600116993616, 7275.381592564586, 7299.41604671625, 6900.171979362509, 6940.201876784134, 6954.652267386711, 7084.079069720903, 7139.571625702474, 4284.0, 4431.113777244564, 4493.213687604656, 4517.909641807146, 4540.72755634663, 1801.1714611278696, 1812.5649844037337, 1816.97274540882, 1817.736428217901, 1845.8984755838558, 855.7347222361088, 865.0674214413144, 877.5480627476854, 877.6796469288792, 968.8449848024424, 15416.533354663425, 15561.377544898078, 15649.84350156484, 15851.841481585037, 16055.598610034609, 869.7825543614097, 905.6830109461636, 907.0249481807084, 952.8332541805295, 965.6764983730388, 9400.529973501298, 9487.0, 9572.808543829224, 9603.231741460666, 9635.22918166545, 448464.0, 455825.0, 465455.0, 467613.0, 471916.0, 65397.0, 68055.65972170107, 69458.30541694518, 69719.3028069723, 71910.0, 1027.4503140819625, 1045.2839804733783, 1047.910927571165, 1047.9423631700329, 1061.1616822710128, 14471.421143154155, 14747.55757327282, 14775.556733298019, 14798.408063677763, 14849.40602375936, 29886.85056574703, 30075.0, 30689.846550767103, 33275.500867486524, 33755.493667595496, 37965.0, 39665.40501892416, 40165.19669606533, 42341.576584233764, 42458.363124553776, 7177.318154775288, 7259.274072592699, 7307.525010874276, 7375.557466552024, 7377.5204611700065, 10607.787844242917, 10826.67519974402, 10945.83581246298, 11053.226274160732, 11145.164112691418, 3008.0374280230117, 6619.801405957829, 9241.445513269226, 9491.860976682843, 9496.382735122195, 9452.905470945203, 9611.327207095435, 9612.855807162758, 9633.470159141314, 9878.0, 9613.182879455324, 9717.9028209717, 9776.657816976372, 9937.254705896941, 9993.200543956611, 7432.21961694036, 7587.203343648837, 7607.961960190164, 7694.307512323918, 7743.883841742266, 9879.259055571005, 10013.148882345082, 10129.139023182817, 10237.181025517792, 10267.794644107225], "unit": "score", "name": "jquery.html", "value": 7916.687815431203}, {"lowerIsBetter": false, "replicates": [1443.451488434395, 1444.6605047813766, 1571.0, 1726.4938510487632, 1735.3058776489395, 7433.145188303347, 7523.247675232474, 7586.089669239699, 7749.728759493419, 7894.407919406053, 7941.841163176733, 7944.086430060544, 7968.601569921495, 8058.476199047058, 8074.91925080749, 2380.440596459835, 2387.295747754408, 2406.867622280774, 2409.819263555232, 2418.141559746291, 2367.1005018093188, 2368.14746691191, 2371.3241726108063, 2377.940551486218, 2418.2140804238607, 2217.6008318502663, 2244.1135751378197, 2256.717910261217, 2272.534130503251, 2282.281081459335, 2327.5810354136247, 2334.7315058768204, 2351.5767161910935, 2356.8703721295324, 2367.5856725073045, 2268.4215525041172, 2269.6028195065796, 2270.591293567157, 2274.65880117982, 2278.7835155660187, 7734.535927844291, 7801.0638723352995, 7809.062912450542, 7819.29626333627, 7821.100573434071, 4859.586935110485, 4990.625703072248, 4990.775415106329, 5021.297018417425, 5025.1708468102715, 3164.5886034815326, 3206.7113959743733, 3249.057773245756, 3258.234314935988, 3264.689854463822, 999.3703966501058, 1003.8745156855393, 1025.9945253651388, 1051.9474026298653, 1957.354073155855, 10534.78930421395, 10543.84184237237, 10561.996610322007, 10620.256582039261, 10656.04095631397, 4379.299312110111, 4429.202743506135, 4498.0, 4620.884477888079, 4667.929981050287, 8553.23020928107, 8636.438631488933, 8638.17937295956, 8654.610542525601, 8697.173768491983, 4891.55975962158, 4910.0, 4914.827981020719, 4926.285688575136, 4928.975355123202, 4515.864524064284, 4516.187086324428, 4526.88682782933, 4569.725816451024, 4570.314452832035, 3475.270193259393, 3604.3512167810045, 3611.620779818134, 3614.801185934799, 3617.8552857885916, 1072.9141668666489, 1094.1301665176204, 1104.0725790336155, 1106.5573770491867, 1133.7811852258856, 1256.7109564800148, 1270.955516556916, 1278.2458349573797, 1331.6870535424168, 1334.5796074236584, 7308.96345518269, 7364.189939106694, 7374.594397308092, 7411.0, 7413.2957369049855, 997.2072202598952, 1030.6959446963165, 1092.983605245922, 1098.4013712526692, 1099.5052226498108, 5566.888662226733, 5638.802641907596, 5650.26546548946, 5682.232898558642, 5699.8860022800145, 8796.0, 9138.406003609743, 9167.26661867049, 9260.861087083698, 9595.088466595662, 9196.402233854778, 9235.307351948632, 9271.0, 9289.303302252358, 9337.579808908615, 7231.819204519824, 7324.571708516788, 7381.926180738231, 7411.5553066816165, 7518.323350898336, 7000.684969176501, 7067.0, 7077.327653872874, 7084.752033678797, 7087.539309944837, 7960.6417711201975, 8006.079300880473, 8117.10711821711, 8154.38842086834, 8259.545724985184, 8000.83998320042, 8330.916690833257, 8347.707830225912, 8380.916190838014, 8479.448835825651, 6958.582485050711, 6960.408365289007, 6984.678801122436, 7116.074910261633, 7130.322619351154, 7535.24647535264, 7548.66031028616, 7564.773056808304, 7585.734499292498, 7646.694132234648, 6951.721931122698, 7079.752208672672, 7091.716331346688, 7243.130824301117, 7476.813079673052, 7070.434365250665, 7092.609906454988, 7108.9289107110335, 7176.390006849268, 7216.747413840701, 7106.502544821813, 7122.60825654594, 7131.679074441558, 7185.0, 7186.065811444479, 6471.288158302489, 6501.0, 6503.6097834130105, 6518.837029074121, 6529.444997175293, 6615.0, 6637.53537252407, 6639.767608133692, 6641.402273795382, 6649.501287403561], "unit": "score", "name": "mootools.html", "value": 4560.058098279314}, {"lowerIsBetter": false, "replicates": [347.5308333749439, 352.17942194686384, 352.3200223568513, 356.8572570971612, 358.7488757869492, 6237.064440333952, 6240.4695600873865, 6316.831386193551, 6355.205599300093, 6466.612003279794, 6233.438990490855, 6248.218972628421, 6274.184356033721, 6285.371462853713, 6314.810555683337, 4766.833160839371, 4774.925641730618, 4778.0, 4800.967791924744, 4806.3511425957395, 4763.333133361332, 4773.64197685175, 4778.54603812639, 4779.665423420362, 4786.808527658889, 4639.860804175863, 4710.411198600175, 4740.502247264039, 4742.241241401376, 4759.071980963713, 4688.991866748665, 4692.202325604655, 4717.080169366957, 4730.881727956794, 4748.6438517111355, 4083.2650122977852, 4090.6931980101613, 4109.383592461125, 4110.424540564323, 4112.691548133872, 5994.0, 6009.939900601025, 6011.669358185298, 6014.609050411709, 6018.879622407571, 5403.78384864605, 5576.86057848553, 5587.0, 5587.776488940438, 5594.356648985378, 6622.1722284714415, 6642.0, 6645.102911106987, 6646.700898459581, 6658.400743933069, 4574.473935497427, 4578.9771051144535, 4579.496255411902, 4584.518625544303, 4585.151746926829, 6775.864482710367, 6875.07186529817, 6949.756758513478, 6957.304269573053, 6960.3387678171, 4680.110778951988, 4680.7191568506, 4687.39063921688, 4688.413948256468, 4694.36626055485, 4726.787294571753, 4741.312509686145, 4745.193317136095, 4746.525347465225, 4752.667313288037, 5484.232207490954, 5488.7530061147345, 5489.615726899079, 5513.393526712059, 5515.641483303572, 6529.902051469232, 6666.166729158856, 6668.633225172662, 6673.699683514254, 6675.86648267032, 1639.434395133677, 1657.1962598139892, 1689.1469807747255, 1691.5432833134985, 1692.5430133863788, 1106.9391183484825, 1124.0445621221895, 1126.9605563805228, 1128.3173679923693, 1140.3727949627837, 6125.693715314216, 6230.7819226326865, 6244.1570387997035, 6254.781082662085, 6259.311475737665, 6708.698108585126, 6726.899096513556, 6753.08833307507, 6755.3582409671, 6762.69567869447, 6054.212952316258, 6200.81397558074, 6202.162708034448, 6205.689715514206, 6214.223222097238, 3649.59854416014, 3677.3380791457794, 3678.742488025866, 3679.5032670589662, 3684.613115622875, 7076.32774886385, 7084.043654106733, 7091.25541818112, 7092.751753688596, 7108.928910710827, 6900.0, 6901.378875901193, 6935.583864968017, 6945.40964018054, 6957.79126626202, 7191.460640451987, 7229.8554028919125, 7246.130464344313, 7260.23767504415, 7305.780826575211, 6846.726130954706, 6883.690233939585, 6920.515563910478, 6925.445964322741, 6944.0278361030505, 6779.880800977571, 6784.76253331131, 6846.452283817183, 6857.759978400732, 6879.346462086094, 7203.8559228816175, 7222.422206223595, 7232.710691572278, 7256.45576581769, 7266.237045110399, 4541.84103556374, 4618.676692631483, 4629.097326021528, 4635.3278774578175, 4639.420072490939, 6811.182658080864, 6927.965360173167, 6954.269801670752, 6957.617331046841, 6976.337247961435, 6788.947713104477, 6802.727890884309, 6804.96597517029, 6811.012403201409, 6832.829179270558, 6748.69630866622, 6803.829904252433, 6804.625745583842, 6808.523403361717, 6825.761098361533, 6452.838679033061, 6616.933830661632, 6633.071370008299, 6636.203655561363, 6657.3342665733035, 6765.627890466071, 6812.965935170292, 6833.384995350442, 6843.863122737617, 6857.588544687334, 6623.668816559057, 6645.435138013323, 6651.16860392451, 6668.233153187251, 6675.632840193836], "unit": "score", "name": "prototype.html", "value": 5013.9471044737975}, {"lowerIsBetter": false, "replicates": [830.9709160179395, 837.6272558711375, 838.0488145954344, 844.6621351459415, 848.7581039403772, 12691.61925142246, 12702.110852240347, 12749.490020399173, 12785.488580456771, 12809.423575939081, 12924.483020679185, 12952.093353465261, 12959.35203239839, 12990.090693651448, 12992.870071299285, 645.4062262718298, 659.7328082126746, 796.3111908199423, 806.2864365036926, 810.1007881251805, 793.773774474275, 796.6853093028251, 803.5941849366062, 805.3557154276584, 810.6676262732251, 826.4627991805314, 838.4172999765166, 841.3563623827777, 842.2924743215698, 847.7117779954814, 829.701307529292, 837.9036410812773, 841.6086519768306, 842.1788755962948, 842.7808769719855, 620.2649859916014, 621.0435928669888, 621.7637297826797, 621.9968900155516, 622.0296337713182, 12896.0, 13025.088243822936, 13123.409446574831, 13273.137246078973, 13294.40175192109, 12921.741565168739, 13183.274919879403, 13302.60092197226, 13334.599962001155, 13336.466541338335, 10113.544890479947, 10343.896561034444, 10583.523741431654, 10591.94704026475, 10607.416592087433, 3583.6953858922025, 3674.210044840372, 3674.4488326751202, 3761.0785357587292, 3762.9623703762886, 45163.32255016177, 45542.0, 45702.77148614236, 45898.311525327146, 45959.77020114911, 9320.487373194404, 9343.813123737624, 9460.57427415768, 9562.900266469445, 9642.228621710246, 18651.533711657044, 18675.15961781723, 18678.719819202724, 18812.435626931216, 18846.43460696181, 7578.0, 7600.46796724224, 7728.729494467667, 7996.80007999793, 8011.7997050073045, 4035.53591337, 4112.712110152261, 4125.154343359604, 4135.669146468275, 4149.564295748964, 3140.4975203967256, 3153.385089907492, 3160.4943209086896, 3163.6994485523837, 3178.078357276364, 536.549298589187, 557.6208178438619, 561.7556362982034, 573.5411670663452, 574.1158615731727, 513.9614528910272, 532.0609124894564, 559.6642014791092, 563.9182318563785, 614.9269524679373, 8059.798505037421, 8204.466709663853, 8208.671653133928, 8229.177082291722, 8419.83160336802, 528.7646997086337, 542.3735585398871, 581.058684930407, 702.2731472925498, 711.4841739738752, 3832.2718683450057, 3925.097227637659, 3931.1154990126993, 3994.660453861396, 4020.8793736187963, 54702.452975469736, 55218.44781552214, 57033.42966570364, 58449.70775146097, 58586.7070664644, 47159.76420117946, 47491.0, 47607.28589071167, 52593.47406525886, 54535.0, 45373.773131134796, 46461.76769116201, 46658.30012549814, 47706.5229347709, 47844.9999999993, 8604.956975215084, 8793.472391656522, 8803.33974951894, 8828.117188281121, 8828.558572071242, 32403.675963240064, 32730.0, 33093.17267068342, 33641.46764589781, 33772.662273376955, 38613.80693096516, 42943.355849662905, 43007.569924300355, 43152.784236078616, 43923.34114988214, 11153.721156970816, 11449.484773185393, 11476.655700329004, 11773.0, 11988.340641264815, 11994.400279985792, 12025.579104731642, 12439.564615238423, 12882.742345153232, 13061.934690326867, 10294.536745846304, 11399.772004560029, 11426.2001659883, 11539.365334906324, 11690.278358937681, 10924.945375273073, 11671.416429178338, 11806.704832378915, 11830.11274154459, 12091.395430228278, 11337.829932551183, 11427.828582571101, 11568.363739994382, 11687.18189726711, 11718.361418936625, 8744.341196092457, 8855.690050848189, 8903.866442003504, 8943.284537236876, 9203.493807840632, 8932.821343572961, 9051.773705657148, 9902.798291485577, 10015.599376024877, 10021.74945626336], "unit": "score", "name": "yui.html", "value": 6221.456215477567}], "name": "dromaeo_css", "value": 6855.357461566825}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 112.0, 111.0, 113.0, 122.0, 111.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [153.0, 128.0, 156.0, 163.0, 132.0, 154.0, 157.0, 136.0, 164.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 164.0, 163.0, 163.0, 164.0, 164.0, 175.0, 163.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 74.0, 74.0, 74.0, 146.0, 73.0, 76.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 149.0, 96.0, 99.0, 96.0, 144.0, 98.0, 97.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 111.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 112.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 153.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 98.0, 97.0, 96.0, 97.0, 97.0, 98.0, 100.0], "unit": "score", "name": "imaging-desaturate", "value": 97.3}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 63.0, 64.0, 62.0, 62.0, 63.0, 63.0, 71.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 63.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 85.0, 83.0, 81.0, 82.0, 82.0, 91.0, 83.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [117.0, 128.0, 131.0, 138.0, 118.0, 117.0, 122.0, 120.0, 124.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [135.0, 148.0, 148.0, 145.0, 145.0, 131.0, 144.0, 141.0, 145.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 69.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1520.8999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.88037126160194], "unit": "score", "name": "Richards", "value": 205.3870359999999}, {"lowerIsBetter": false, "replicates": [190.5850962454736], "unit": "score", "name": "DeltaBlue", "value": 346.9211459999999}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5324.468085106383], "unit": "score", "name": "Decrypt", "value": 49.99203596403597}, {"lowerIsBetter": false, "replicates": [1085.7763300760043], "unit": "score", "name": "RayTrace", "value": 681.5298690000002}, {"lowerIsBetter": false, "replicates": [727.802037845706], "unit": "score", "name": "Earley", "value": 915.720162}, {"lowerIsBetter": false, "replicates": [12658.227848101265], "unit": "score", "name": "Boyer", "value": 52.65057700000003}, {"lowerIsBetter": false, "replicates": [40820.0], "unit": "score", "name": "RegExp", "value": 22.317123958843723}, {"lowerIsBetter": false, "replicates": [636.5372374283895], "unit": "score", "name": "Splay", "value": 128.02236099999996}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20021.36407996238}]} 20:08:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20021.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1520.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6855.36"}}} 20:08:19 INFO - Return code: 0 20:08:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:08:19 INFO - # TBPL SUCCESS # 20:08:19 INFO - Running post-action listener: _resource_record_post_action 20:08:19 INFO - Running post-run listener: _resource_record_post_run 20:08:20 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 568147968; Read time: 0; Write time: 487924 20:08:20 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 253726720; Read time: 0; Write time: 294440 20:08:20 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 314421248; Read time: 0; Write time: 193484 20:08:20 INFO - Running post-run listener: _upload_blobber_files 20:08:20 INFO - Blob upload gear active. 20:08:20 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:08:20 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 20:08:20 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'] 20:08:20 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 20:08:21 INFO - (blobuploader) - INFO - Open directory for files ... 20:08:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:08:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:08:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:08:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:08:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:08:22 INFO - (blobuploader) - INFO - Done attempting. 20:08:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:08:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:08:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:08:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:08:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:08:23 INFO - (blobuploader) - INFO - Done attempting. 20:08:23 INFO - (blobuploader) - INFO - Iteration through files over. 20:08:23 INFO - Return code: 0 20:08:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:08:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:08:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/526fa120d8a00eaa33dc3a933c8659b633f48b7c617ff4ebc950455fe8dde1e3c1404fb0da6f2235db0ae78ce6e580d4428d17d111ec991329d6b13bb303443e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb5958fd5601c0c4735a7cf484829335d0b956b1937cf9e66a5d58d31f8abf37d47a6c504975b95d8ff4ec1c644ce378a1e18fd7ca7ad878e96e69a9ca69cc1b"} 20:08:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:08:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:08:23 INFO - Contents: 20:08:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/526fa120d8a00eaa33dc3a933c8659b633f48b7c617ff4ebc950455fe8dde1e3c1404fb0da6f2235db0ae78ce6e580d4428d17d111ec991329d6b13bb303443e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb5958fd5601c0c4735a7cf484829335d0b956b1937cf9e66a5d58d31f8abf37d47a6c504975b95d8ff4ec1c644ce378a1e18fd7ca7ad878e96e69a9ca69cc1b"} 20:08:23 INFO - Running post-run listener: copy_logs_to_upload_dir 20:08:23 INFO - Copying logs to upload dir... 20:08:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:08:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.613101 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-19 20:08:22.317918) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 20:08:22.321299) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648 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/526fa120d8a00eaa33dc3a933c8659b633f48b7c617ff4ebc950455fe8dde1e3c1404fb0da6f2235db0ae78ce6e580d4428d17d111ec991329d6b13bb303443e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb5958fd5601c0c4735a7cf484829335d0b956b1937cf9e66a5d58d31f8abf37d47a6c504975b95d8ff4ec1c644ce378a1e18fd7ca7ad878e96e69a9ca69cc1b"} build_url:https://queue.taskcluster.net/v1/task/cv2D7QpQTKONj-TTyAr-1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/cv2D7QpQTKONj-TTyAr-1g/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/526fa120d8a00eaa33dc3a933c8659b633f48b7c617ff4ebc950455fe8dde1e3c1404fb0da6f2235db0ae78ce6e580d4428d17d111ec991329d6b13bb303443e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb5958fd5601c0c4735a7cf484829335d0b956b1937cf9e66a5d58d31f8abf37d47a6c504975b95d8ff4ec1c644ce378a1e18fd7ca7ad878e96e69a9ca69cc1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 20:08:22.346621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 20:08:22.346965) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453261343.872689-1542642648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 20:08:22.431247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 20:08:22.431634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 20:08:22.432052) ========= ========= Total master_lag: 0.31 =========