builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1450464637.87 results: success (0) buildid: 20151218083105 builduid: 63f2ebf6e9be46459b75620663a90ea4 revision: 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.872714) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.873089) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.873368) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006190 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.901104) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.901384) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.973154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.973425) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022879 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.023999) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.024273) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.024612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.024882) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 10:50:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 80.6M=0s 2015-12-18 10:50:38 (80.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116819 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.153616) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.153897) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.044707 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.208403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.208702) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 --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 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 10:50:38,318 truncating revision to first 12 chars 2015-12-18 10:50:38,318 Setting DEBUG logging. 2015-12-18 10:50:38,318 attempt 1/10 2015-12-18 10:50:38,318 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2a25cd6b592f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 10:50:38,548 unpacking tar archive at: fx-team-2a25cd6b592f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562869 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.784813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.785125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.795329) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.795681) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.796112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-18 10:50:38.796394) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:39 INFO - MultiFileLogger online at 20151218 10:50:39 in /builds/slave/test-pgo 10:50:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:50:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:50:39 INFO - {'append_to_log': False, 10:50:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:50:39 INFO - 'blob_upload_branch': 'Fx-Team', 10:50:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:50:39 INFO - 'branch': 'Fx-Team', 10:50:39 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:39 INFO - 'config_files': ('talos/linux_config.py',), 10:50:39 INFO - 'default_actions': ('clobber', 10:50:39 INFO - 'read-buildbot-config', 10:50:39 INFO - 'download-and-extract', 10:50:39 INFO - 'populate-webroot', 10:50:39 INFO - 'create-virtualenv', 10:50:39 INFO - 'install', 10:50:39 INFO - 'run-tests'), 10:50:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:39 INFO - 'download_minidump_stackwalk': True, 10:50:39 INFO - 'download_symbols': 'ondemand', 10:50:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:39 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:39 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:39 INFO - 'installer_path': 'installer.exe', 10:50:39 INFO - 'log_level': 'info', 10:50:39 INFO - 'log_name': 'talos', 10:50:39 INFO - 'log_to_console': True, 10:50:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:39 INFO - 'opt_config_files': (), 10:50:39 INFO - 'pip_index': False, 10:50:39 INFO - 'sps_profile': False, 10:50:39 INFO - 'sps_profile_interval': 0, 10:50:39 INFO - 'suite': 'dromaeojs-e10s', 10:50:39 INFO - 'system_bits': '64', 10:50:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:39 INFO - 'title': 'talos-linux64-ix-035', 10:50:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:39 INFO - 'use_talos_json': True, 10:50:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:50:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:39 INFO - 'work_dir': 'build'} 10:50:39 INFO - ##### 10:50:39 INFO - ##### Running clobber step. 10:50:39 INFO - ##### 10:50:39 INFO - Running pre-action listener: _resource_record_pre_action 10:50:39 INFO - Running main action method: clobber 10:50:39 INFO - rmtree: /builds/slave/test-pgo/build 10:50:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:50:39 INFO - Running post-action listener: _resource_record_post_action 10:50:39 INFO - ##### 10:50:39 INFO - ##### Running read-buildbot-config step. 10:50:39 INFO - ##### 10:50:39 INFO - Running pre-action listener: _resource_record_pre_action 10:50:39 INFO - Running main action method: read_buildbot_config 10:50:39 INFO - Using buildbot properties: 10:50:39 INFO - { 10:50:39 INFO - "project": "", 10:50:39 INFO - "product": "firefox", 10:50:39 INFO - "script_repo_revision": "production", 10:50:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:50:39 INFO - "repository": "", 10:50:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:50:39 INFO - "buildid": "20151218083105", 10:50:39 INFO - "pgo_build": "True", 10:50:39 INFO - "basedir": "/builds/slave/test-pgo", 10:50:39 INFO - "buildnumber": 394, 10:50:39 INFO - "slavename": "talos-linux64-ix-035", 10:50:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:50:39 INFO - "platform": "ubuntu64_hw", 10:50:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:50:39 INFO - "branch": "fx-team", 10:50:39 INFO - "repo_path": "integration/fx-team", 10:50:39 INFO - "revision": "2a25cd6b592f4f3b942d3fb8476ce10a0e071d65", 10:50:39 INFO - "stage_platform": "linux64-pgo", 10:50:39 INFO - "builduid": "63f2ebf6e9be46459b75620663a90ea4", 10:50:39 INFO - "slavebuilddir": "test" 10:50:39 INFO - } 10:50:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:50:39 INFO - Running post-action listener: _resource_record_post_action 10:50:39 INFO - ##### 10:50:39 INFO - ##### Running download-and-extract step. 10:50:39 INFO - ##### 10:50:39 INFO - Running pre-action listener: _resource_record_pre_action 10:50:39 INFO - Running main action method: download_and_extract 10:50:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:50:39 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')]} 10:50:39 INFO - https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/test_packages.json 10:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/test_packages.json 10:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:50:41 INFO - Downloaded 1302 bytes. 10:50:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:50:41 INFO - Using the following test package requirements: 10:50:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:50:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:41 INFO - u'jsshell-linux-x86_64.zip'], 10:50:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:50:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:50:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:50:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:50:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:50:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:50: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')]} 10:50:41 INFO - https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/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 10:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/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 10:50:48 INFO - Downloaded 23120938 bytes. 10:50:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:50:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:50:49 INFO - Return code: 0 10:50:49 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 10:50:49 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')]} 10:50:49 INFO - https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/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 10:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/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 10:50:51 INFO - Downloaded 23120938 bytes. 10:50:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:50:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:50:52 INFO - Return code: 0 10:50:52 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')]} 10:50:52 INFO - https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/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 10:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/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 10:50:54 INFO - Downloaded 11132039 bytes. 10:50:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:50:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:50:54 INFO - Return code: 0 10:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:54 INFO - https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/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 10:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/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 10:50:55 INFO - Downloaded 54647542 bytes. 10:50:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:55 INFO - mkdir: /builds/slave/test-pgo/properties 10:50:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:50:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:50:55 INFO - Contents: 10:50:55 INFO - build_url:https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:55 INFO - Running post-action listener: _resource_record_post_action 10:50:55 INFO - Running post-action listener: set_extra_try_arguments 10:50:55 INFO - ##### 10:50:55 INFO - ##### Running populate-webroot step. 10:50:55 INFO - ##### 10:50:55 INFO - Running pre-action listener: _resource_record_pre_action 10:50:55 INFO - Running main action method: populate_webroot 10:50:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:50:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:50:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:50:55 INFO - '--tppagecycles', 10:50:55 INFO - '7'], 10:50:55 INFO - 'tests': ['tsvgm']}}, 10:50:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:50:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:50:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:50:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:50:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:50:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:50:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:55 INFO - 'talos_options': ['--e10s'], 10:50:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:55 INFO - 'tests': ['damp', 'tps']}, 10:50:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:55 INFO - 'talos_options': ['--e10s'], 10:50:55 INFO - 'tests': ['damp', 'tps']}, 10:50:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:50:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:55 INFO - 'other': {'tests': ['a11yr', 10:50:55 INFO - 'ts_paint', 10:50:55 INFO - 'tpaint', 10:50:55 INFO - 'sessionrestore', 10:50:55 INFO - 'sessionrestore_no_auto_restore']}, 10:50:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:50:55 INFO - 'tests': ['a11yr', 10:50:55 INFO - 'ts_paint', 10:50:55 INFO - 'tpaint', 10:50:55 INFO - 'sessionrestore', 10:50:55 INFO - 'sessionrestore_no_auto_restore']}, 10:50:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:50:55 INFO - 'tests': ['a11yr', 10:50:55 INFO - 'ts_paint', 10:50:55 INFO - 'tpaint', 10:50:55 INFO - 'sessionrestore', 10:50:55 INFO - 'sessionrestore_no_auto_restore']}, 10:50:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:50:55 INFO - 'tests': ['a11yr', 10:50:55 INFO - 'ts_paint', 10:50:55 INFO - 'tpaint', 10:50:55 INFO - 'sessionrestore', 10:50:55 INFO - 'sessionrestore_no_auto_restore']}, 10:50:55 INFO - 'other_l64': {'tests': ['a11yr', 10:50:55 INFO - 'ts_paint', 10:50:55 INFO - 'tpaint', 10:50:55 INFO - 'sessionrestore', 10:50:55 INFO - 'sessionrestore_no_auto_restore']}, 10:50:55 INFO - 'other_nol64': {'tests': ['a11yr', 10:50:55 INFO - 'ts_paint', 10:50:55 INFO - 'tpaint', 10:50:55 INFO - 'sessionrestore', 10:50:55 INFO - 'sessionrestore_no_auto_restore']}, 10:50:55 INFO - 'svgr': {'tests': ['tsvgx', 10:50:55 INFO - 'tsvgr_opacity', 10:50:55 INFO - 'tart', 10:50:55 INFO - 'tscrollx', 10:50:55 INFO - 'cart']}, 10:50:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:50:55 INFO - 'tests': ['tsvgx', 10:50:55 INFO - 'tsvgr_opacity', 10:50:55 INFO - 'tart', 10:50:55 INFO - 'tscrollx', 10:50:55 INFO - 'cart']}, 10:50:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:55 INFO - 'tests': ['tp5o']}, 10:50:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:55 INFO - 'talos_options': ['--e10s'], 10:50:55 INFO - 'tests': ['tp5o']}, 10:50:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:55 INFO - 'talos_options': ['--xperf_path', 10:50:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:55 INFO - 'tests': ['tp5n']}, 10:50:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:55 INFO - 'talos_options': ['--e10s', 10:50:55 INFO - '--xperf_path', 10:50:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:55 INFO - 'tests': ['tp5n']}}, 10:50:55 INFO - 'talos.zip': {'path': '', 10:50:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:50:55 INFO - Running post-action listener: _resource_record_post_action 10:50:55 INFO - ##### 10:50:55 INFO - ##### Running create-virtualenv step. 10:50:55 INFO - ##### 10:50:55 INFO - Running pre-action listener: _resource_record_pre_action 10:50:55 INFO - Running main action method: create_virtualenv 10:50:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:50:55 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 10:50:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:50:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:55 INFO - Using real prefix '/usr' 10:50:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:50:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:50:58 INFO - Installing pip.................done. 10:50:58 INFO - Return code: 0 10:50:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f877f923f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1508600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1597350>, '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 0x1598250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15986e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', '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 10:50:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:50:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:50:58 INFO - Using env: {'DISPLAY': ':0', 10:50:58 INFO - 'HOME': '/home/cltbld', 10:50:58 INFO - 'LANG': 'en_US.UTF-8', 10:50:58 INFO - 'LANGUAGE': 'en_US:en', 10:50:58 INFO - 'LOGNAME': 'cltbld', 10:50:58 INFO - 'MAIL': '/var/mail/cltbld', 10:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:58 INFO - 'MOZ_NO_REMOTE': '1', 10:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:58 INFO - 'NO_EM_RESTART': '1', 10:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:50:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:50:58 INFO - 'SHELL': '/bin/bash', 10:50:58 INFO - 'SHLVL': '1', 10:50:58 INFO - 'TERM': 'linux', 10:50:58 INFO - 'TMOUT': '86400', 10:50:58 INFO - 'USER': 'cltbld', 10:50:58 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', 10:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:58 INFO - '_': '/tools/buildbot/bin/python'} 10:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:58 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 10:50:58 INFO - Cleaning up... 10:50:58 INFO - Return code: 0 10:50:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f877f923f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1508600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1597350>, '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 0x1598250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15986e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', '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 10:50:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:50:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:50:58 INFO - Using env: {'DISPLAY': ':0', 10:50:58 INFO - 'HOME': '/home/cltbld', 10:50:58 INFO - 'LANG': 'en_US.UTF-8', 10:50:58 INFO - 'LANGUAGE': 'en_US:en', 10:50:58 INFO - 'LOGNAME': 'cltbld', 10:50:58 INFO - 'MAIL': '/var/mail/cltbld', 10:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:58 INFO - 'MOZ_NO_REMOTE': '1', 10:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:58 INFO - 'NO_EM_RESTART': '1', 10:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:50:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:50:58 INFO - 'SHELL': '/bin/bash', 10:50:58 INFO - 'SHLVL': '1', 10:50:58 INFO - 'TERM': 'linux', 10:50:58 INFO - 'TMOUT': '86400', 10:50:58 INFO - 'USER': 'cltbld', 10:50:58 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', 10:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:58 INFO - '_': '/tools/buildbot/bin/python'} 10:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:58 INFO - Downloading/unpacking psutil>=0.7.1 10:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:51:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:51:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:00 INFO - Installing collected packages: psutil 10:51:00 INFO - Running setup.py install for psutil 10:51:00 INFO - building 'psutil._psutil_linux' extension 10:51:00 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 10:51:00 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 10:51:00 INFO - building 'psutil._psutil_posix' extension 10:51:00 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 10:51:00 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 10:51:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:00 INFO - Successfully installed psutil 10:51:00 INFO - Cleaning up... 10:51:00 INFO - Return code: 0 10:51:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f877f923f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1508600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1597350>, '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 0x1598250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15986e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', '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 10:51:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:51:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:51:00 INFO - Using env: {'DISPLAY': ':0', 10:51:00 INFO - 'HOME': '/home/cltbld', 10:51:00 INFO - 'LANG': 'en_US.UTF-8', 10:51:00 INFO - 'LANGUAGE': 'en_US:en', 10:51:00 INFO - 'LOGNAME': 'cltbld', 10:51:00 INFO - 'MAIL': '/var/mail/cltbld', 10:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:00 INFO - 'MOZ_NO_REMOTE': '1', 10:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:00 INFO - 'NO_EM_RESTART': '1', 10:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:00 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:00 INFO - 'SHELL': '/bin/bash', 10:51:00 INFO - 'SHLVL': '1', 10:51:00 INFO - 'TERM': 'linux', 10:51:00 INFO - 'TMOUT': '86400', 10:51:00 INFO - 'USER': 'cltbld', 10:51:00 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', 10:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:00 INFO - '_': '/tools/buildbot/bin/python'} 10:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:51:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:51:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:51:02 INFO - Installing collected packages: mozsystemmonitor 10:51:02 INFO - Running setup.py install for mozsystemmonitor 10:51:02 INFO - Successfully installed mozsystemmonitor 10:51:02 INFO - Cleaning up... 10:51:03 INFO - Return code: 0 10:51:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:03 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 0x7f877f923f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1508600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1597350>, '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 0x1598250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15986e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', '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 10:51:03 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 10:51:03 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 10:51:03 INFO - Using env: {'DISPLAY': ':0', 10:51:03 INFO - 'HOME': '/home/cltbld', 10:51:03 INFO - 'LANG': 'en_US.UTF-8', 10:51:03 INFO - 'LANGUAGE': 'en_US:en', 10:51:03 INFO - 'LOGNAME': 'cltbld', 10:51:03 INFO - 'MAIL': '/var/mail/cltbld', 10:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:03 INFO - 'MOZ_NO_REMOTE': '1', 10:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:03 INFO - 'NO_EM_RESTART': '1', 10:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:03 INFO - 'SHELL': '/bin/bash', 10:51:03 INFO - 'SHLVL': '1', 10:51:03 INFO - 'TERM': 'linux', 10:51:03 INFO - 'TMOUT': '86400', 10:51:03 INFO - 'USER': 'cltbld', 10:51:03 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', 10:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:03 INFO - '_': '/tools/buildbot/bin/python'} 10:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:04 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:51:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:51:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:51:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:05 INFO - Downloading docopt-0.6.1.tar.gz 10:51:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:51:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:05 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:05 INFO - Running setup.py install for blobuploader 10:51:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:51:05 INFO - Running setup.py install for requests 10:51:06 INFO - Running setup.py install for docopt 10:51:06 INFO - Successfully installed blobuploader requests docopt 10:51:06 INFO - Cleaning up... 10:51:06 INFO - Return code: 0 10:51:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51: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')]} 10:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:06 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 0x7f877f923f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1508600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1597350>, '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 0x1598250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15986e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', '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 10:51:06 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 10:51:06 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 10:51:06 INFO - Using env: {'DISPLAY': ':0', 10:51:06 INFO - 'HOME': '/home/cltbld', 10:51:06 INFO - 'LANG': 'en_US.UTF-8', 10:51:06 INFO - 'LANGUAGE': 'en_US:en', 10:51:06 INFO - 'LOGNAME': 'cltbld', 10:51:06 INFO - 'MAIL': '/var/mail/cltbld', 10:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:06 INFO - 'MOZ_NO_REMOTE': '1', 10:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:06 INFO - 'NO_EM_RESTART': '1', 10:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:06 INFO - 'SHELL': '/bin/bash', 10:51:06 INFO - 'SHLVL': '1', 10:51:06 INFO - 'TERM': 'linux', 10:51:06 INFO - 'TMOUT': '86400', 10:51:06 INFO - 'USER': 'cltbld', 10:51:06 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', 10:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:06 INFO - '_': '/tools/buildbot/bin/python'} 10:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:06 INFO - Running setup.py (path:/tmp/pip-lGQhdM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:06 INFO - Running setup.py (path:/tmp/pip-N78hF0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:06 INFO - Running setup.py (path:/tmp/pip-uBPtPP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:06 INFO - Running setup.py (path:/tmp/pip-kXA4r3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:06 INFO - Running setup.py (path:/tmp/pip-xaQGDz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:06 INFO - Running setup.py (path:/tmp/pip-MWWxog-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:06 INFO - Running setup.py (path:/tmp/pip-YB6lwb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:06 INFO - Running setup.py (path:/tmp/pip-J19WuC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:07 INFO - Running setup.py (path:/tmp/pip-QG_g4n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:07 INFO - Running setup.py (path:/tmp/pip-A7mTW3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:07 INFO - Running setup.py (path:/tmp/pip-gPK6xZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:07 INFO - Running setup.py (path:/tmp/pip-l2dFrQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:07 INFO - Running setup.py (path:/tmp/pip-vPjaeU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:07 INFO - Running setup.py (path:/tmp/pip-e_eh8W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:07 INFO - Running setup.py (path:/tmp/pip-6E3q96-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:07 INFO - Running setup.py (path:/tmp/pip-d2suqV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:07 INFO - Running setup.py (path:/tmp/pip-ypFVEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:07 INFO - Running setup.py install for manifestparser 10:51:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:51:07 INFO - Running setup.py install for mozcrash 10:51:07 INFO - Running setup.py install for mozdebug 10:51:07 INFO - Running setup.py install for mozdevice 10:51:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:51:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:51:08 INFO - Running setup.py install for mozfile 10:51:08 INFO - Running setup.py install for mozhttpd 10:51:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:51:08 INFO - Running setup.py install for mozinfo 10:51:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:51:08 INFO - Running setup.py install for mozInstall 10:51:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:51:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:51:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:51:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:51:08 INFO - Running setup.py install for mozleak 10:51:08 INFO - Running setup.py install for mozlog 10:51:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:51:08 INFO - Running setup.py install for moznetwork 10:51:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:51:08 INFO - Running setup.py install for mozprocess 10:51:08 INFO - Running setup.py install for mozprofile 10:51:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:51:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:51:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:51:09 INFO - Running setup.py install for mozrunner 10:51:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:51:09 INFO - Running setup.py install for mozscreenshot 10:51:09 INFO - Running setup.py install for moztest 10:51:09 INFO - Running setup.py install for mozversion 10:51:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:51:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:09 INFO - Cleaning up... 10:51:09 INFO - Return code: 0 10:51:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f877f923f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1508600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1597350>, '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 0x1598250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15986e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', '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 10:51:09 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 10:51:09 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 10:51:09 INFO - Using env: {'DISPLAY': ':0', 10:51:09 INFO - 'HOME': '/home/cltbld', 10:51:09 INFO - 'LANG': 'en_US.UTF-8', 10:51:09 INFO - 'LANGUAGE': 'en_US:en', 10:51:09 INFO - 'LOGNAME': 'cltbld', 10:51:09 INFO - 'MAIL': '/var/mail/cltbld', 10:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:09 INFO - 'MOZ_NO_REMOTE': '1', 10:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:09 INFO - 'NO_EM_RESTART': '1', 10:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:09 INFO - 'SHELL': '/bin/bash', 10:51:09 INFO - 'SHLVL': '1', 10:51:09 INFO - 'TERM': 'linux', 10:51:09 INFO - 'TMOUT': '86400', 10:51:09 INFO - 'USER': 'cltbld', 10:51:09 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', 10:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:09 INFO - '_': '/tools/buildbot/bin/python'} 10:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:09 INFO - Running setup.py (path:/tmp/pip-RvHBMt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:09 INFO - Running setup.py (path:/tmp/pip-DMVFR7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:09 INFO - Running setup.py (path:/tmp/pip-Dck89H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:09 INFO - Running setup.py (path:/tmp/pip-waoHzr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:09 INFO - Running setup.py (path:/tmp/pip-VwLj2d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:10 INFO - Running setup.py (path:/tmp/pip-6HTk2g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:10 INFO - Running setup.py (path:/tmp/pip-3n8ybH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:10 INFO - Running setup.py (path:/tmp/pip-HOCL2a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:10 INFO - Running setup.py (path:/tmp/pip-6r1qgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:10 INFO - Running setup.py (path:/tmp/pip-XGx2DO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:10 INFO - Running setup.py (path:/tmp/pip-WSwmuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:10 INFO - Running setup.py (path:/tmp/pip-INQaBo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:10 INFO - Running setup.py (path:/tmp/pip-fEPwRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:10 INFO - Running setup.py (path:/tmp/pip-5Kv1nk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:10 INFO - Running setup.py (path:/tmp/pip-Y6Ngl4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:10 INFO - Running setup.py (path:/tmp/pip-g2B6WD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:10 INFO - Running setup.py (path:/tmp/pip-xu8xGD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:10 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 10:51:10 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 10:51:10 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 10:51:10 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 10:51:10 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 10:51:10 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 10:51:12 INFO - Downloading blessings-1.5.1.tar.gz 10:51:12 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 10:51:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:12 INFO - Installing collected packages: blessings 10:51:12 INFO - Running setup.py install for blessings 10:51:12 INFO - Successfully installed blessings 10:51:12 INFO - Cleaning up... 10:51:12 INFO - Return code: 0 10:51:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:51:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:51:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:51:13 INFO - Reading from file tmpfile_stdout 10:51:13 INFO - Current package versions: 10:51:13 INFO - argparse == 1.2.1 10:51:13 INFO - blessings == 1.5.1 10:51:13 INFO - blobuploader == 1.2.4 10:51:13 INFO - docopt == 0.6.1 10:51:13 INFO - manifestparser == 1.1 10:51:13 INFO - mozInstall == 1.12 10:51:13 INFO - mozcrash == 0.16 10:51:13 INFO - mozdebug == 0.1 10:51:13 INFO - mozdevice == 0.47 10:51:13 INFO - mozfile == 1.2 10:51:13 INFO - mozhttpd == 0.7 10:51:13 INFO - mozinfo == 0.9 10:51:13 INFO - mozleak == 0.1 10:51:13 INFO - mozlog == 3.1 10:51:13 INFO - moznetwork == 0.27 10:51:13 INFO - mozprocess == 0.22 10:51:13 INFO - mozprofile == 0.27 10:51:13 INFO - mozrunner == 6.11 10:51:13 INFO - mozscreenshot == 0.1 10:51:13 INFO - mozsystemmonitor == 0.0 10:51:13 INFO - moztest == 0.7 10:51:13 INFO - mozversion == 1.4 10:51:13 INFO - psutil == 3.1.1 10:51:13 INFO - requests == 1.2.3 10:51:13 INFO - wsgiref == 0.1.2 10:51:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51:13 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')]} 10:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:13 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')]} 10:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:13 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 0x7f877f923f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1508600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1597350>, '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 0x1598250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15986e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', '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 10:51:13 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 10:51:13 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 10:51:13 INFO - Using env: {'DISPLAY': ':0', 10:51:13 INFO - 'HOME': '/home/cltbld', 10:51:13 INFO - 'LANG': 'en_US.UTF-8', 10:51:13 INFO - 'LANGUAGE': 'en_US:en', 10:51:13 INFO - 'LOGNAME': 'cltbld', 10:51:13 INFO - 'MAIL': '/var/mail/cltbld', 10:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:13 INFO - 'MOZ_NO_REMOTE': '1', 10:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:13 INFO - 'NO_EM_RESTART': '1', 10:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:13 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:13 INFO - 'SHELL': '/bin/bash', 10:51:13 INFO - 'SHLVL': '1', 10:51:13 INFO - 'TERM': 'linux', 10:51:13 INFO - 'TMOUT': '86400', 10:51:13 INFO - 'USER': 'cltbld', 10:51:13 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', 10:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:13 INFO - '_': '/tools/buildbot/bin/python'} 10:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:13 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 1)) 10:51:13 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 2)) 10:51:13 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 3)) 10:51:13 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 4)) 10:51:13 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 5)) 10:51:13 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 6)) 10:51:13 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 7)) 10:51:13 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 8)) 10:51:13 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:51:13 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 3)) 10:51:13 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:51:13 INFO - Cleaning up... 10:51:13 INFO - Return code: 0 10:51:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:51:13 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')]} 10:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:13 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')]} 10:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:13 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 0x7f877f923f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1508600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1597350>, '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 0x1598250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15986e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', '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 10:51:13 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 10:51:13 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 10:51:13 INFO - Using env: {'DISPLAY': ':0', 10:51:13 INFO - 'HOME': '/home/cltbld', 10:51:13 INFO - 'LANG': 'en_US.UTF-8', 10:51:13 INFO - 'LANGUAGE': 'en_US:en', 10:51:13 INFO - 'LOGNAME': 'cltbld', 10:51:13 INFO - 'MAIL': '/var/mail/cltbld', 10:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:13 INFO - 'MOZ_NO_REMOTE': '1', 10:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:13 INFO - 'NO_EM_RESTART': '1', 10:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:13 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:13 INFO - 'SHELL': '/bin/bash', 10:51:13 INFO - 'SHLVL': '1', 10:51:13 INFO - 'TERM': 'linux', 10:51:13 INFO - 'TMOUT': '86400', 10:51:13 INFO - 'USER': 'cltbld', 10:51:13 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', 10:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:13 INFO - '_': '/tools/buildbot/bin/python'} 10:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:13 INFO - Downloading/unpacking jsonschema 10:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:15 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 10:51:15 INFO - Downloading/unpacking functools32 (from jsonschema) 10:51:15 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 10:51:15 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 10:51:15 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 10:51:15 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 10:51:15 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 10:51:15 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 10:51:15 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:51:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:15 INFO - warning: no files found matching '*.txt' 10:51:15 INFO - no previously-included directories found matching 'build' 10:51:15 INFO - no previously-included directories found matching 'dist' 10:51:15 INFO - no previously-included directories found matching '.git*' 10:51:15 INFO - Installing collected packages: jsonschema, functools32 10:51:15 INFO - Running setup.py install for functools32 10:51:15 INFO - warning: no files found matching '*.txt' 10:51:15 INFO - no previously-included directories found matching 'build' 10:51:15 INFO - no previously-included directories found matching 'dist' 10:51:15 INFO - no previously-included directories found matching '.git*' 10:51:15 INFO - Successfully installed jsonschema functools32 10:51:15 INFO - Cleaning up... 10:51:15 INFO - Return code: 0 10:51:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:51: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')]} 10:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:15 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 0x7f877f923f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1508600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1597350>, '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 0x1598250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15986e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', '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 10:51:15 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 10:51:15 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 10:51:15 INFO - Using env: {'DISPLAY': ':0', 10:51:15 INFO - 'HOME': '/home/cltbld', 10:51:15 INFO - 'LANG': 'en_US.UTF-8', 10:51:15 INFO - 'LANGUAGE': 'en_US:en', 10:51:15 INFO - 'LOGNAME': 'cltbld', 10:51:15 INFO - 'MAIL': '/var/mail/cltbld', 10:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:15 INFO - 'MOZ_NO_REMOTE': '1', 10:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:15 INFO - 'NO_EM_RESTART': '1', 10:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:15 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:15 INFO - 'SHELL': '/bin/bash', 10:51:15 INFO - 'SHLVL': '1', 10:51:15 INFO - 'TERM': 'linux', 10:51:15 INFO - 'TMOUT': '86400', 10:51:15 INFO - 'USER': 'cltbld', 10:51:15 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', 10:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:15 INFO - '_': '/tools/buildbot/bin/python'} 10:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:15 INFO - Downloading/unpacking flake8 10:51:15 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 10:51:15 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 10:51:15 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 10:51:15 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 10:51:15 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 10:51:15 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 10:51:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:51:17 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 10:51:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:51:17 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 10:51:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 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 10:51:17 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 10:51:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:51:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:51:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:51:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:51:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:51:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:51:18 INFO - no previously-included directories found matching 'docs/_build' 10:51:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:51:18 INFO - Running setup.py install for pep8 10:51:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:51:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:51:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:51:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:51:18 INFO - no previously-included directories found matching 'docs/_build' 10:51:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:51:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:51:18 INFO - Cleaning up... 10:51:18 INFO - Return code: 0 10:51:18 INFO - Running post-action listener: _resource_record_post_action 10:51:18 INFO - Running post-action listener: _start_resource_monitoring 10:51:18 INFO - Starting resource monitoring. 10:51:18 INFO - ##### 10:51:18 INFO - ##### Running install step. 10:51:18 INFO - ##### 10:51:18 INFO - Running pre-action listener: _resource_record_pre_action 10:51:18 INFO - Running main action method: install 10:51:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:51:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:51:18 INFO - Reading from file tmpfile_stdout 10:51:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:51:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:51:18 INFO - Reading from file tmpfile_stdout 10:51:18 INFO - Output received: 10:51:18 INFO - Usage: mozinstall [options] installer 10:51:18 INFO - Options: 10:51:18 INFO - -h, --help show this help message and exit 10:51:18 INFO - -d DEST, --destination=DEST 10:51:18 INFO - Directory to install application into. [default: 10:51:18 INFO - "/builds/slave/test-pgo"] 10:51:18 INFO - --app=APP Application being installed. [default: firefox] 10:51:18 INFO - mkdir: /builds/slave/test-pgo/build/application 10:51:18 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'] 10:51:18 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 10:51:34 INFO - Reading from file tmpfile_stdout 10:51:34 INFO - Output received: 10:51:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:51:34 INFO - Running post-action listener: _resource_record_post_action 10:51:34 INFO - ##### 10:51:34 INFO - ##### Running run-tests step. 10:51:34 INFO - ##### 10:51:34 INFO - Running pre-action listener: _resource_record_pre_action 10:51:34 INFO - Running main action method: run_tests 10:51:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:51:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:51:34 INFO - Python 2.7.3 10:51:34 INFO - Return code: 0 10:51:34 INFO - grabbing minidump binary from tooltool 10:51: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')]} 10:51:34 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 0x1597350>, '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 0x1598250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15986e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:51:34 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 10:51:34 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 10:51:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:51:34 INFO - Return code: 0 10:51:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:51:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:51:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:51:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:51:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:51:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:51:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:51:35 INFO - Return code: 0 10:51:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:51:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 10:51:35 INFO - Using env: {'DISPLAY': ':0', 10:51:35 INFO - 'HOME': '/home/cltbld', 10:51:35 INFO - 'LANG': 'en_US.UTF-8', 10:51:35 INFO - 'LANGUAGE': 'en_US:en', 10:51:35 INFO - 'LOGNAME': 'cltbld', 10:51:35 INFO - 'MAIL': '/var/mail/cltbld', 10:51:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:51:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:35 INFO - 'MOZ_NO_REMOTE': '1', 10:51:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:35 INFO - 'NO_EM_RESTART': '1', 10:51:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:35 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:51:35 INFO - 'SHELL': '/bin/bash', 10:51:35 INFO - 'SHLVL': '1', 10:51:35 INFO - 'TERM': 'linux', 10:51:35 INFO - 'TMOUT': '86400', 10:51:35 INFO - 'USER': 'cltbld', 10:51:35 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565', 10:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:35 INFO - '_': '/tools/buildbot/bin/python'} 10:51:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 10:51:35 INFO - mozversion INFO | application_buildid: 20151218083105 10:51:35 INFO - mozversion INFO | application_changeset: 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 10:51:35 INFO - mozversion INFO | application_display_name: Nightly 10:51:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:51:35 INFO - mozversion INFO | application_name: Firefox 10:51:35 INFO - mozversion INFO | application_remotingname: firefox 10:51:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:51:35 INFO - mozversion INFO | application_vendor: Mozilla 10:51:35 INFO - mozversion INFO | application_version: 46.0a1 10:51:35 INFO - mozversion INFO | platform_buildid: 20151218083105 10:51:35 INFO - mozversion INFO | platform_changeset: 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 10:51:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:51:35 INFO - mozversion INFO | platform_version: 46.0a1 10:51:35 INFO - 2015-12-18 10:51:35,592 DEBUG : using testdate: 1450464695 10:51:35 INFO - 2015-12-18 10:51:35,592 DEBUG : actual date: 1450464695 10:51:35 INFO - 2015-12-18 10:51:35,601 INFO : starting webserver on 'localhost:55092' 10:51:35 INFO - 2015-12-18 10:51:35,602 INFO : Starting test suite talos-linux64-ix-035.e 10:51:35 INFO - 2015-12-18 10:51:35,602 INFO : Starting test dromaeo_css 10:51:35 INFO - 2015-12-18 10:51:35,602 DEBUG : operating with platform_type : linux_ 10:51:35 INFO - 2015-12-18 10:51:35,603 INFO : Initialising browser for dromaeo_css test... 10:51:35 INFO - 2015-12-18 10:51:35,619 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXuAyy9/profile http://localhost:55092/getInfo.html 10:51:40 INFO - 2015-12-18 10:51:40,105 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:51:40 INFO - 2015-12-18 10:51:40,105 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:51:40 INFO - 2015-12-18 10:51:40,105 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:51:40 INFO - 2015-12-18 10:51:40,105 DEBUG : BROWSER_OUTPUT: __metrics 10:51:40 INFO - 2015-12-18 10:51:40,229 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:51:41 INFO - 2015-12-18 10:51:41,045 INFO : Browser initialized. 10:51:41 INFO - 2015-12-18 10:51:41,046 INFO : Running cycle 1/1 for dromaeo_css test... 10:51:41 INFO - 2015-12-18 10:51:41,046 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXuAyy9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:51:52 INFO - 2015-12-18 10:51:52,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 151437312 10:51:52 INFO - 2015-12-18 10:51:52,888 DEBUG : BROWSER_OUTPUT: 10:52:42 INFO - 2015-12-18 10:52:42,502 DEBUG : BROWSER_OUTPUT: 1450464762501 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] 10:54:51 INFO - 2015-12-18 10:54:51,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55092/tests/dromaeo/cssquery-ext.html) 10:54:52 INFO - 2015-12-18 10:54:52,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 157425664 10:54:52 INFO - 2015-12-18 10:54:52,511 DEBUG : BROWSER_OUTPUT: 10:57:54 INFO - 2015-12-18 10:57:54,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/dromaeo/cssquery-ext.html (next: http://localhost:55092/tests/dromaeo/cssquery-jquery.html) 10:57:55 INFO - 2015-12-18 10:57:55,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 153518080 10:57:55 INFO - 2015-12-18 10:57:55,130 DEBUG : BROWSER_OUTPUT: 11:00:56 INFO - 2015-12-18 11:00:56,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55092/tests/dromaeo/cssquery-mootools.html) 11:00:57 INFO - 2015-12-18 11:00:57,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 153698304 11:00:57 INFO - 2015-12-18 11:00:57,453 DEBUG : BROWSER_OUTPUT: 11:03:59 INFO - 2015-12-18 11:03:59,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55092/tests/dromaeo/cssquery-prototype.html) 11:03:59 INFO - 2015-12-18 11:03:59,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 152748032 11:03:59 INFO - 2015-12-18 11:03:59,704 DEBUG : BROWSER_OUTPUT: 11:07:02 INFO - 2015-12-18 11:07:02,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55092/tests/dromaeo/cssquery-yui.html) 11:07:02 INFO - 2015-12-18 11:07:02,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 153358336 11:07:02 INFO - 2015-12-18 11:07:02,678 DEBUG : BROWSER_OUTPUT: 11:10:05 INFO - 2015-12-18 11:10:05,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/dromaeo/cssquery-yui.html (next: http://localhost:55092/tests/dromaeo/cssquery-dojo.html) 11:10:05 INFO - 2015-12-18 11:10:05,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 155664384 11:10:05 INFO - 2015-12-18 11:10:05,512 DEBUG : BROWSER_OUTPUT: 11:10:05 INFO - 2015-12-18 11:10:05,512 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:10:05 INFO - 2015-12-18 11:10:05,513 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:10:05 INFO - 2015-12-18 11:10:05,513 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:10:05 INFO - 2015-12-18 11:10:05,513 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:10:05 INFO - 2015-12-18 11:10:05,513 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3179.205198700325;3211.470107432274;3238.271388937491;3253.0403530958365;3265.8203798791073;5226.477352264772;5294.232336311233;5334.91997620036;5349.786008559653;5352.598555108363;5289.761960711768;5325.547328477074;5325.866853328669;5345.49217824307;5419.430959749228;4901.142300097486;4914.97542512287;4928.987067361827;4940.580050695695;5070.923936140961;5050.444451110375;5073.670211436245;5109.591232701394;5125.487451254863;5132.589392848563;4753.762311884409;4843.612510999129;4851.393575803025;4862.027594481083;4880.170371036932;4805.663603547753;4887.511248875119;4893.804247830082;4912.631552633567;4915.041566894457;4844.079624871263;4873.926891096601;4877.487863774288;4911.803527858881;4929.383827021622;5074.238864170367;5177.119889618773;5197.454267301954;5229.294045303911;5249.291345668324;5653.434656534355;5704.71476426177;5806.738696758656;5913.142594323799;5941.405859414067;5875.676837773921;5887.7939272125695;5891.293044834647;5903;5919.2009078774245;5502.367227768817;5509.201165830972;5512.3936367;5512.80705175317;5518.117101263819;5833.270841144857;5847.502962248172;5882.058870580687;5918.7928422505;5923.17075609415;5675.4324567543745;5729.914051289234;5738.340090889601;5749.626274292157;5781.046127388934;5542.5565954723525;5796.565257605696;5813.82558523245;5818.709064546756;5854.648721076749;5721.342045664802;5819.912701309484;5914.8817023659285;5924.5852790305125;5979.19280897082;5733.168690539932;5737.741801618937;5746.683932383759;5771.913421298684;5773.134029895466;4358.760268185217;4429.712068715523;4476.888077798081;4482.731036137842;4513.029698614813;3926.764394136361;3950.7827069511454;3952.407138929126;3969.6625786807867;3981.124152686404;5519.530839878575;5519.834404967857;5524.116141417354;5535.529479994165;5555.361133469622;5680.431956804369;5738.397468265772;5852.122181672698;5863.442972917566;5889.116632505158;5532.474414930575;5539.723013849291;5561.860953476195;5565.41563135873;5570.61005729595;5025.4974502550185;5055.797768089309;5056.999999999926;5057.31726216956;5094.745262736922;5818.156367326798;5850.678212698257;5915.201447804578;5917.082852157922;5954.55340849438;5742.626729262752;5805.129230615442;5807.274090738658;5845.590808643524;5855.180274761452;5955.047192449188;5972.581919265784;5979.790707325223;5981.730822112929;5993.580449368503;5571.303587051619;5663.433656634304;5757.222774925499;5851.297844258716;5888.587798854039;5733.799317023884;5775.191473193672;5783.16144159103;5788.305403351625;5793.449622285876;5481.972590137024;5599;5656.321241451053;5660.037793575019;5668.801591944262;5486.094794358886;5629.211910332639;5693.345265294379;5694.629849059798;5722.141678748221;5639.7180140993605;5642.266505354278;5654.321481422256;5658.20785090096;5678.20505129274;5664.461876121762;5772.018756811436;5788.131780232999;5809.82570522885;5833.79581714638;5435.972820135874;5512.80705175317;5524.889502210013;5526.696031718133;5554.777808887599 11:10:05 INFO - 2015-12-18 11:10:05,517 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.2531083037896;561.7247548701138;568.247072628767;568.8037627018679;575.3010092737323;37384.81307593462;38139.427908581325;38142.8092859536;38167.236655266875;38314.42528362073;42187.367189492106;42767.57232427675;43019.139617207635;43048.13903721931;43085.35371969423;8550.444221125637;8698.39111262212;8701.521416322099;8713.3464990126;8721.30229581632;8508.064112947572;8530.23227909488;8585.441946273504;8587.570621468933;8611.26804221642;8568.700095496659;8616.956915215414;8619.569021548929;8701.695440659578;8703.260222881063;8595.398322117455;8610.741677749678;8632.007319158283;8666.52334121623;8698.304135669163;8457.407981441302;8528.573571321409;8539.35954803386;8569.143085691443;8609.784755381103;38870.80564597187;39006.60993390058;39246;39256.60743392586;39312.410313845314;3265.951010734841;3334.9666503334897;3591.730620203495;3597.5503062117236;3846.268909741817;29356.266093347836;29720.70279297201;29885.655145518504;30087.548686769715;30098.398032039237;3835.827387767557;3942.7831469269177;4009.83960641574;4047.4131250968444;4101.692373072032;254776;254908;255827;255901;255903.72048139825;55391.44608553863;55558.72220638871;55715.44284557102;55789;55986;58458;58755;59899;60283;67192;13707.520236791665;13716.902647788153;13808.378622961991;13809.792853107212;13811.723765524634;10669.306495077795;10714.19643526723;10717.035466808025;10768.515416806262;10772.407517586607;19159.233630654617;19345.51636209106;19415.902920485307;19479.318223862098;19491.317803876795;7310.890336644955;7459.776206713807;7488.925110748823;7559.470837041465;7600.594638278391;922.6032805893531;937.5406051034944;968.3415277611151;1011.4740335025892;1067.524951396621;28016.85991570029;28035.43929121447;28180.718192818218;28485.430291394056;28595.428091438054;1031.4997226345217;1069.9411532365639;1071.7106381277013;1101.9118769930935;1140.994295028536;13483.528076517276;13588.796168057486;13856.93071534656;13893.722125557635;14349.713005739826;295928;299475;299602;299645;299834;49306.75346623316;49732;49806.252906206435;49885.50114498881;49903;1328.9401976911063;1334.9920809788741;1338.3977210255423;1342.536824795444;1360.1634994478325;26488.470230594896;27028.594571081056;27131.86434067896;27456.45087098287;27556.862215688794;44637.33044004277;44866.55133448754;44951.775241123585;45045.54954450545;45112.54887451084;287045;290077;291165;292343;292364;30298.545521817632;31590.842045789625;31615.84192079117;31854.522182166824;32040.5193922096;35983.82008090048;36724.44913326356;36966.630333697394;37205.255894882495;37539.49842006289;32115.67884321127;33027.00918972435;34103;34295.971120866416;34548.48177277393;34340.31319373648;34678.82660586681;37437.81281093686;37792.62207378001;38205;33763;33869.15327116842;33918.491222631186;34143;34218.315633687685;30778.230544236572;31051.844740776152;31400.214994625316;31533.36933261276;31545.842270789417;24179.15372961938;24349.634755478328;24547.877260613583;24785.380365491008;24858.129965451124 11:10:05 INFO - 2015-12-18 11:10:05,517 DEBUG : BROWSER_OUTPUT: |2;jquery.html;361.1278761790276;361.1332801276935;361.79739345966277;361.84621535847276;367.03835949811497;16282.26729797159;16953.237104330303;17452.47642570725;17485;17961.550961225978;15616.45342413013;15725.60685982851;15801.288941997609;15857.524274271791;16099;4960.330355402019;5108.157154069574;5113.258577506259;5121.3342265505435;5126.794928202868;4992.375953005874;5081.466446023152;5100.387953445592;5122.795088196468;5124.538791508763;5058.418281897573;5088.720120393377;5171.2760213569945;5312.654677445973;5319.3616765987945;4947.431045429786;5289.709066001368;5306.628536002481;5357.624966252364;5590.720463976785;5392.352917649868;5393.622446428752;5396.514313711785;5408.0535906216255;5431.9185212221455;12707.491700331975;14297.78553321701;16825.822192446532;20665;20750.688739668916;2104.95790084199;2106.2680867567656;2119.5548934723724;2150.9890351534755;2229.320057382498;9257.768555786091;9672.371295865747;10992.670219893416;13107.34463276842;13483.19100853952;1787.356551641421;1846.18767742193;1846.704527275643;1911.7419148414924;1915.4732448576613;62241.4203059364;62582;63352;65484.67257663681;65543.01685474721;10056.094951454257;10229.590816367261;10239.334443261165;10311.381317120997;10336.793264134676;13490.662733431744;13548.390322435514;13551.051426400254;13551.39018744159;13555.457781688621;6878.449724022066;6895.75864844738;6998.440124790005;7160.713571457188;7164.104486939133;6724.731010759613;6793.592384456949;6807.523473356818;6870.484713646497;6875.621840798804;4250.596193361625;4295.548967358445;4329.978350108292;4330.2205602991135;4421.4915284742665;1626.9755953660704;1755.5172327609755;1811;1819.2631984046482;1837.7151541511087;832.2385017708729;922.280621115531;989.7080361293292;1010.6462738041773;1016.2885979814012;16439.178041097897;17266;17521.474355769093;17600.295988160586;18178.727319090223;900.1178844732199;931.8648795924553;934.6261495401893;962.2975228083538;972.8054389122204;9002.819943601222;9120.179183873483;9200.355975081813;9211.032841551674;9294.767630809283;141591;144434.5556544421;144618;524344;526966;81439;82083.17916820756;82673;84009.15990840136;84084.15915840886;1109.6060898380958;1128.4990962020656;1130.6155906991662;1149.4540093455541;1156.5200441816721;14921.701565968837;15092.320845561757;15093.698126037638;15155.545333640008;15516.612084697972;33022.76294348759;35276.29447410986;35656.82171589125;36041.0989725259;36156.4576531347;47048.54611256708;47670.52329476661;47688.761556191996;48711.75644121757;51059.48940510696;9092;9248.907510925073;9262.675806347015;9298.95350523243;9337.20633746112;10829.51267192994;13721.588352349445;17742.20160092825;17971.820281797016;18376.724349135042;13536.661583460493;13821.723565528835;13865.584032479042;14657.48698795537;14689.41242350294;13902.51341203053;14082.577522674335;14304.642383940485;14528.128312301296;14564.85435145635;14261.42954281817;14366.56900292993;14728.26358682083;14740.262986850401;14804.259787010391;9565.139137477661;9578.712638620853;9991.750206244902;9992.550335235077;10103.898961010296;11485.712857178638;15041.473548426191;15156.848431515544;15209.315580799112;15278.618034548781 11:10:05 INFO - 2015-12-18 11:10:05,520 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1423.238567366459;1493.096676510711;1591.7930669013026;1594.9043057416548;1722.1905704318965;6331.873362532758;6393;6978.790636280907;7428.6657100430475;7445.888311675322;6559;6765.12053433053;7041.15506139264;7202.387797037245;7219.0976127984;2089.9895500522516;2128.744550653916;2134.3170185540635;2145.678148277763;2149.892505374733;2112.039022244875;2136.604728125294;2164.404788683109;2179.509610337669;2182.5853087913324;2086.2698055680544;2126.723525941633;2136.166894910986;2178.2376168341034;2185.071344678513;2129.55279391328;2157.4067131538873;2180.7819218078225;2180.967285490719;2183.62878310686;2057.6296266671993;2096.8846713430753;2117.110813458351;2117.6400011998;2118.0257081742416;7286.672099755524;7357.190709022003;7358.448116391239;7370.96314518424;7386.704531818775;4305.56944305567;4403.471583409979;4407.206702793496;4407.405000324947;4420.690551661385;2910.57796619489;2951.6605590357167;2954.7340739333563;2973.68776278492;2982.970170298291;966.9033096690345;969.5927710361665;984.2814745236018;1009.545704433008;1021.4637315409395;9307.39501932379;9480.288978326584;9504.762380940463;9507.809843803085;9507.952460237655;3766.7174961877968;3840.1743625120735;3864.7101467390057;3866.555346135174;3879.321118804198;8044.919550804417;8058.0733215679775;8123.47197432165;8141.755747327589;8158.67365305393;4340.587644173798;4373.081652852937;4373.497047839539;4406.889827754268;4411.933820992687;3933.5476420212044;4038.9798051009557;4053.5135783706146;4055.7160998729805;4092.3656833190903;3295.060907641359;3326.966730332714;3327.068420842168;3335.949960750591;3358.697717205463;1030.6598822388594;1036.5231993283023;1041.4896700616644;1048.6120135549895;1052.0531521630442;939.7650587353162;947.7583216279943;949.7055912667096;974.6198982396871;1177.3583397048628;6760.7295708172105;6772.848615735337;6787.04981302618;6801.7619383322335;6806.965965170142;455.90426010537493;466.5987250964168;473.90521895621015;477.5582586107906;480.742802600607;5404.594655400861;5430.701311427831;5431.538319242909;5473.370562385297;5476.151196564539;8414.242718155396;8433.325333973267;8723.694670686622;8767.123287671182;8771.386002979858;8589.44168629037;8599.226069653636;8648.524331161721;8702.82594348122;8717.869231961526;6884.896726549106;6908.792736217922;6914.274001229899;6934.930650693428;7007.719691212396;6664.333566643297;6668;6672.232693240146;6673.332666733288;6691.866162676816;7342.596157211405;7538.623068846426;7578.12851522082;7685.730999414994;7737.264959828807;7809.570473624005;7844.529328240324;7868.567228802471;7877.566733829465;7896.84206315859;5591.329040515164;5873.911891321548;6589.439897608757;6646.60120392778;6650.035744817072;6896.241413444617;6924.272951340238;6944.618046007518;6959.095317608679;6967.268436814062;6343.207099112611;6445.480649126476;6529.575577587441;6573.638449885302;6583.3087525811015;6526.771562995273;6540.738370465128;6575.901361479678;6650.401463868275;6657;6473.158489396348;6503.577267477599;6518.837029074311;6533.248676402274;6537.803865884031;5610.18652295423;5817.825465236049;5883.0881213411985;5907.940920590739;5918.704064796657;6040.6979651018155;6065.60573562717;6075.483583895419;6077.848053798691;6117.388261174025 11:10:05 INFO - 2015-12-18 11:10:05,522 DEBUG : BROWSER_OUTPUT: |4;prototype.html;340.0766917818123;341.40765771386657;346.5858299332297;347.2343482620821;348.20956428906385;6216.067589861523;6260.123582698426;6318;6356.777512787054;6401.8399540011405;6098.237720284965;6232.563720539564;6257;6272.56092073555;6274.498040156788;4783.928241076378;4805.687630304036;4820.638452116088;4824.300476430933;4828.299896515004;4831.347768051321;4832.395950506187;4834.613230941533;4837.274408838684;4845.200541910581;4710.646701497384;4786.234202527597;4819.084373968953;4824.300476430915;4827.155247831633;4788.0423915216925;4803.759812009385;4814.374131362935;4816.7832447539595;4823.807047718087;4216.51510076342;4230.746155230696;4249.766262855542;4258.318669012974;4259.382389553529;5958.374370691058;5973.133895585159;5985.910211346833;6004.459598636144;6015.909761353583;5464.26232458621;5608.691521966291;5609.52319052881;5612.326520817487;5619.157126431027;6638.93361066388;6679.465642748569;6690.431313338372;6693.464522838161;6693.732250710014;4629.3750343703505;4629.398178236841;4637.698549594299;4645.279981602857;4651.3255577941345;6838.076859623937;6882.69027893746;6903.516753827234;6947.861042779116;6967.09427774386;4625.699329543569;4641.930371044437;4648.97675511627;4653.86038418848;4655.301704744315;4688.296755486705;4708.317293992352;4717.009428020086;4720.598749106364;4725.669203155746;5442.91835622466;5484.588655850827;5498.202760599771;5506.972465137648;5520.944790552124;6526.151600291932;6701.061851340816;6728.158980127484;6729.158855143107;6746.763863264762;1631.8776091793163;1669.766232727419;1672.1639180409795;1674.1796519705256;1675.2293944785292;1073.4364458659265;1105.8396532502902;1110.2838669058413;1117.273772048159;1139.1342579639368;6347.143135676717;6383.457406120532;6403.743850245938;6412.294647588761;6417.935820641827;6827.317268273232;6848.14398200225;6870.725170993204;6874.690638921261;6882.380585747307;6395.616263024233;6397.6801159941815;6404.7117879695525;6412.006139048455;6415.716856628693;3823.9044023899623;3835.1179228776978;3859.826307816155;3860.131470419133;3865.8260378283044;7195.676194571257;7245.166805817293;7247.637618119073;7263.273672632695;7265.963670181721;7070.151581810215;7201.675924583406;7253.673584688701;7256.383207427428;7263.527870688388;7175.17485489165;7177.533460325167;7219.747308844166;7230.710771569184;7266.745663901633;7015.36861682451;7069.681864316221;7091.255418181223;7102.112235970504;7107.786766397016;6742.898856517254;6916.515843890879;6935.410490108397;6989.720411183699;7001.929980700128;7277.563346199245;7287.2348403419;7292.124945006633;7295.781126566211;7302.2697730226555;4694.671373003857;4712.057588482386;4719.457262414729;4745.193317136026;4747.074320507468;6867.381935625618;6923.792286231421;7044.049053377728;7073.929260707533;7075.540089894346;6798.048273241651;6821.863562728817;6830.419414349637;6850.349216824394;6866.588004719732;6820.761273355409;6822.692978816064;6850.903855383115;6854.554453960476;6876.106106206161;6590.340965903371;6724.394804467622;6730.798076057726;6747.898781518183;6753.15585551806;6877.828054298682;6879.965600172167;6908.378245957687;6912.170539535288;6913.10129683138;6670.533062685759;6672.266050734513;6700.363465470772;6704.832379190364;6713.56361836479 11:10:05 INFO - 2015-12-18 11:10:05,522 DEBUG : BROWSER_OUTPUT: |5;yui.html;764.4648745877887;822.4982760516087;825.6944930375762;842.1494290766328;848.0501837941505;13573.321333933302;13736.58790236292;13820.930895345535;13874.514391996283;13888.375023123972;13169.670758231048;13211.537596184135;13635.659108522266;13696.109752866081;13703.246321452341;776.2664282253273;780.9062912450514;785.2853902948318;799.8240387114826;805.1586092533288;792.1207459719707;795.7970717467067;797.6928882380296;798.7284323330067;798.7883210949074;827.210014436212;835.9916400835974;837.8868852704868;839.6725277141919;843.161054750524;818.5825229133155;826.3554427546524;826.7437094500724;830.8753686946945;831.6049876308765;607.6232735703848;608.0089454189687;609.0711664711306;609.1259043272918;610.1092405088576;13921.651958701012;13958.232297223649;13974.860251397458;14035.50875719345;14073.225972571505;11567.652970410902;11982.820257696141;12015.339156346397;12025;12186.390680465942;10316.432596207205;10439.843402348972;10464.947675261652;10507.317024393466;10667.359958402521;3582.140286331262;3593.0658028912408;3698.85204591816;3708.7033037356946;3716.572594151653;47851;48210.276845847344;48254;48404.51595484035;48558.271625925285;9875.555599998017;10043.849342259871;10078.294519383719;10330.793384132276;10438.425886576311;15594;15606.765898511532;15628.062316261061;15633.60915977087;15638.9218053909;7244.529105608224;7249.96375018132;7274.666773006818;7519.473636845478;7539.547627142389;3905.1018265798457;4122.7732474713575;4230.428892099527;4350.195213885441;4433.645308375322;2908.0984894682715;2919.0658989123276;2934.413117376533;2937.1041832240944;2943.234758962685;526.5287567627029;531.8829857431359;536.8630999095205;546.6528754241006;549.3023859698161;613.411125319698;643.1606753187135;654.2672207128047;675.8344205669642;676.8104930619435;8232.547209903512;8379.49723016621;8521.147885211429;8563.143685631512;8598.87101693475;544.77119609764;572.3303734630492;684.6645143879463;686.5419911701989;693.9063226464363;3823.2544653792243;4077.082656402345;4098.405731168964;4123.835046598162;4146.937795933063;53335.73332133392;53815;53835.19247211295;54102.45897540974;54197.1870421944;49945.25082123771;50107.74946125319;50602.746986264836;50607.49392506028;51191;45430.318545221846;45785.08429831451;45935;46549.534504655196;47059;8024.317932975762;8059.556724380215;8154.959225203836;8294.25351718324;8307.83384332322;34122;34202.82898585491;34565.48151777675;34677;34847;42398.576014239465;43482.78258608687;44036.33945490884;44262.33606495841;44335.77832110819;9920.503974801086;9999.900001000187;10248.38509689421;10264.024917632813;10511.159107271247;10763.138948884227;10808.945955270174;10989.61536346224;11277.830832537682;11344.546218151181;10323;10335.121514671036;10711.625093121704;10716.785664286826;10771.730706732395;10246.846297305696;10311.839980121755;10386.272960892666;10440.68677939663;10568.841467377842;10293.845592316271;10376.009526039645;10575.312604680672;10575.524101415609;10710.283895405899;8814.427062240933;8946.507942063248;8959.328050396116;9518.524073796421;9524.714258572254;8703.999040110468;8844.380893337404;9100.77248068777;9183.678571249975;9227.953860230657 11:10:05 INFO - 2015-12-18 11:10:05,522 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:10:05 INFO - 2015-12-18 11:10:05,522 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:10:05 INFO - 2015-12-18 11:10:05,522 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,308 11:10:05 INFO - 2015-12-18 11:10:05,522 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:10:05 INFO - 2015-12-18 11:10:05,522 DEBUG : BROWSER_OUTPUT: __startTimestamp1450465805510__endTimestamp 11:10:05 INFO - 2015-12-18 11:10:05,523 DEBUG : BROWSER_OUTPUT: 11:10:05 INFO - 2015-12-18 11:10:05,523 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:10:05 INFO - 2015-12-18 11:10:05,523 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:10:05 INFO - 2015-12-18 11:10:05,523 DEBUG : BROWSER_OUTPUT: 11:10:05 INFO - 2015-12-18 11:10:05,523 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5384.71 Median:5570.61 stddev:601.68 (10.8%) stddev-sans-first:578.12 11:10:05 INFO - 2015-12-18 11:10:05,524 DEBUG : BROWSER_OUTPUT: Values: 3179.2 3211.5 3238.3 3253.0 3265.8 5226.5 5294.2 5334.9 5349.8 5352.6 5289.8 5325.5 5325.9 5345.5 5419.4 4901.1 4915.0 4929.0 4940.6 5070.9 5050.4 5073.7 5109.6 5125.5 5132.6 4753.8 4843.6 4851.4 4862.0 4880.2 4805.7 4887.5 4893.8 4912.6 4915.0 4844.1 4873.9 4877.5 4911.8 4929.4 5074.2 5177.1 5197.5 5229.3 5249.3 5653.4 5704.7 5806.7 5913.1 5941.4 5875.7 5887.8 5891.3 5903.0 5919.2 5502.4 5509.2 5512.4 5512.8 5518.1 5833.3 5847.5 5882.1 5918.8 5923.2 5675.4 5729.9 5738.3 5749.6 5781.0 5542.6 5796.6 5813.8 5818.7 5854.6 5721.3 5819.9 5914.9 5924.6 5979.2 5733.2 5737.7 5746.7 5771.9 5773.1 4358.8 4429.7 4476.9 4482.7 4513.0 3926.8 3950.8 3952.4 3969.7 3981.1 5519.5 5519.8 5524.1 5535.5 5555.4 5680.4 5738.4 5852.1 5863.4 5889.1 5532.5 5539.7 5561.9 5565.4 5570.6 5025.5 5055.8 5057.0 5057.3 5094.7 5818.2 5850.7 5915.2 5917.1 5954.6 5742.6 5805.1 5807.3 5845.6 5855.2 5955.0 5972.6 5979.8 5981.7 5993.6 5571.3 5663.4 5757.2 5851.3 5888.6 5733.8 5775.2 5783.2 5788.3 5793.4 5482.0 5599.0 5656.3 5660.0 5668.8 5486.1 5629.2 5693.3 5694.6 5722.1 5639.7 5642.3 5654.3 5658.2 5678.2 5664.5 5772.0 5788.1 5809.8 5833.8 5436.0 5512.8 5524.9 5526.7 5554.8 11:10:05 INFO - 2015-12-18 11:10:05,524 DEBUG : BROWSER_OUTPUT: 11:10:05 INFO - 2015-12-18 11:10:05,525 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44706.57 Median:19135.28 stddev:73715.47 (385.2%) stddev-sans-first:73847.71 11:10:05 INFO - 2015-12-18 11:10:05,525 DEBUG : BROWSER_OUTPUT: Values: 553.3 561.7 568.2 568.8 575.3 37384.8 38139.4 38142.8 38167.2 38314.4 42187.4 42767.6 43019.1 43048.1 43085.4 8550.4 8698.4 8701.5 8713.3 8721.3 8508.1 8530.2 8585.4 8587.6 8611.3 8568.7 8617.0 8619.6 8701.7 8703.3 8595.4 8610.7 8632.0 8666.5 8698.3 8457.4 8528.6 8539.4 8569.1 8609.8 38870.8 39006.6 39246.0 39256.6 39312.4 3266.0 3335.0 3591.7 3597.6 3846.3 29356.3 29720.7 29885.7 30087.5 30098.4 3835.8 3942.8 4009.8 4047.4 4101.7 254776.0 254908.0 255827.0 255901.0 255903.7 55391.4 55558.7 55715.4 55789.0 55986.0 58458.0 58755.0 59899.0 60283.0 67192.0 13707.5 13716.9 13808.4 13809.8 13811.7 10669.3 10714.2 10717.0 10768.5 10772.4 19159.2 19345.5 19415.9 19479.3 19491.3 7310.9 7459.8 7488.9 7559.5 7600.6 922.6 937.5 968.3 1011.5 1067.5 28016.9 28035.4 28180.7 28485.4 28595.4 1031.5 1069.9 1071.7 1101.9 1141.0 13483.5 13588.8 13856.9 13893.7 14349.7 295928.0 299475.0 299602.0 299645.0 299834.0 49306.8 49732.0 49806.3 49885.5 49903.0 1328.9 1335.0 1338.4 1342.5 1360.2 26488.5 27028.6 27131.9 27456.5 27556.9 44637.3 44866.6 44951.8 45045.5 45112.5 287045.0 290077.0 291165.0 292343.0 292364.0 30298.5 31590.8 31615.8 31854.5 32040.5 35983.8 36724.4 36966.6 37205.3 37539.5 32115.7 33027.0 34103.0 34296.0 34548.5 34340.3 34678.8 37437.8 37792.6 38205.0 33763.0 33869.2 33918.5 34143.0 34218.3 30778.2 31051.8 31400.2 31533.4 31545.8 24179.2 24349.6 24547.9 24785.4 24858.1 11:10:05 INFO - 2015-12-18 11:10:05,525 DEBUG : BROWSER_OUTPUT: 11:10:05 INFO - 2015-12-18 11:10:05,525 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22201.89 Median:35466.56 stddev:58637.84 (165.3%) stddev-sans-first:58779.41 11:10:05 INFO - 2015-12-18 11:10:05,525 DEBUG : BROWSER_OUTPUT: Values: 361.1 361.1 361.8 361.8 367.0 16282.3 16953.2 17452.5 17485.0 17961.6 15616.5 15725.6 15801.3 15857.5 16099.0 4960.3 5108.2 5113.3 5121.3 5126.8 4992.4 5081.5 5100.4 5122.8 5124.5 5058.4 5088.7 5171.3 5312.7 5319.4 4947.4 5289.7 5306.6 5357.6 5590.7 5392.4 5393.6 5396.5 5408.1 5431.9 12707.5 14297.8 16825.8 20665.0 20750.7 2105.0 2106.3 2119.6 2151.0 2229.3 9257.8 9672.4 10992.7 13107.3 13483.2 1787.4 1846.2 1846.7 1911.7 1915.5 62241.4 62582.0 63352.0 65484.7 65543.0 10056.1 10229.6 10239.3 10311.4 10336.8 13490.7 13548.4 13551.1 13551.4 13555.5 6878.4 6895.8 6998.4 7160.7 7164.1 6724.7 6793.6 6807.5 6870.5 6875.6 4250.6 4295.5 4330.0 4330.2 4421.5 1627.0 1755.5 1811.0 1819.3 1837.7 832.2 922.3 989.7 1010.6 1016.3 16439.2 17266.0 17521.5 17600.3 18178.7 900.1 931.9 934.6 962.3 972.8 9002.8 9120.2 9200.4 9211.0 9294.8 141591.0 144434.6 144618.0 524344.0 526966.0 81439.0 82083.2 82673.0 84009.2 84084.2 1109.6 1128.5 1130.6 1149.5 1156.5 14921.7 15092.3 15093.7 15155.5 15516.6 33022.8 35276.3 35656.8 36041.1 36156.5 47048.5 47670.5 47688.8 48711.8 51059.5 9092.0 9248.9 9262.7 9299.0 9337.2 10829.5 13721.6 17742.2 17971.8 18376.7 13536.7 13821.7 13865.6 14657.5 14689.4 13902.5 14082.6 14304.6 14528.1 14564.9 14261.4 14366.6 14728.3 14740.3 14804.3 9565.1 9578.7 9991.8 9992.6 10103.9 11485.7 15041.5 15156.8 15209.3 15278.6 11:10:05 INFO - 2015-12-18 11:10:05,525 DEBUG : BROWSER_OUTPUT: 11:10:05 INFO - 2015-12-18 11:10:05,525 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5020.49 Median:6337.54 stddev:2587.21 (40.8%) stddev-sans-first:2580.34 11:10:05 INFO - 2015-12-18 11:10:05,527 DEBUG : BROWSER_OUTPUT: Values: 1423.2 1493.1 1591.8 1594.9 1722.2 6331.9 6393.0 6978.8 7428.7 7445.9 6559.0 6765.1 7041.2 7202.4 7219.1 2090.0 2128.7 2134.3 2145.7 2149.9 2112.0 2136.6 2164.4 2179.5 2182.6 2086.3 2126.7 2136.2 2178.2 2185.1 2129.6 2157.4 2180.8 2181.0 2183.6 2057.6 2096.9 2117.1 2117.6 2118.0 7286.7 7357.2 7358.4 7371.0 7386.7 4305.6 4403.5 4407.2 4407.4 4420.7 2910.6 2951.7 2954.7 2973.7 2983.0 966.9 969.6 984.3 1009.5 1021.5 9307.4 9480.3 9504.8 9507.8 9508.0 3766.7 3840.2 3864.7 3866.6 3879.3 8044.9 8058.1 8123.5 8141.8 8158.7 4340.6 4373.1 4373.5 4406.9 4411.9 3933.5 4039.0 4053.5 4055.7 4092.4 3295.1 3327.0 3327.1 3335.9 3358.7 1030.7 1036.5 1041.5 1048.6 1052.1 939.8 947.8 949.7 974.6 1177.4 6760.7 6772.8 6787.0 6801.8 6807.0 455.9 466.6 473.9 477.6 480.7 5404.6 5430.7 5431.5 5473.4 5476.2 8414.2 8433.3 8723.7 8767.1 8771.4 8589.4 8599.2 8648.5 8702.8 8717.9 6884.9 6908.8 6914.3 6934.9 7007.7 6664.3 6668.0 6672.2 6673.3 6691.9 7342.6 7538.6 7578.1 7685.7 7737.3 7809.6 7844.5 7868.6 7877.6 7896.8 5591.3 5873.9 6589.4 6646.6 6650.0 6896.2 6924.3 6944.6 6959.1 6967.3 6343.2 6445.5 6529.6 6573.6 6583.3 6526.8 6540.7 6575.9 6650.4 6657.0 6473.2 6503.6 6518.8 6533.2 6537.8 5610.2 5817.8 5883.1 5907.9 5918.7 6040.7 6065.6 6075.5 6077.8 6117.4 11:10:05 INFO - 2015-12-18 11:10:05,527 DEBUG : BROWSER_OUTPUT: 11:10:05 INFO - 2015-12-18 11:10:05,527 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5628.88 Median:6389.54 stddev:1719.63 (26.9%) stddev-sans-first:1678.01 11:10:05 INFO - 2015-12-18 11:10:05,527 DEBUG : BROWSER_OUTPUT: Values: 340.1 341.4 346.6 347.2 348.2 6216.1 6260.1 6318.0 6356.8 6401.8 6098.2 6232.6 6257.0 6272.6 6274.5 4783.9 4805.7 4820.6 4824.3 4828.3 4831.3 4832.4 4834.6 4837.3 4845.2 4710.6 4786.2 4819.1 4824.3 4827.2 4788.0 4803.8 4814.4 4816.8 4823.8 4216.5 4230.7 4249.8 4258.3 4259.4 5958.4 5973.1 5985.9 6004.5 6015.9 5464.3 5608.7 5609.5 5612.3 5619.2 6638.9 6679.5 6690.4 6693.5 6693.7 4629.4 4629.4 4637.7 4645.3 4651.3 6838.1 6882.7 6903.5 6947.9 6967.1 4625.7 4641.9 4649.0 4653.9 4655.3 4688.3 4708.3 4717.0 4720.6 4725.7 5442.9 5484.6 5498.2 5507.0 5520.9 6526.2 6701.1 6728.2 6729.2 6746.8 1631.9 1669.8 1672.2 1674.2 1675.2 1073.4 1105.8 1110.3 1117.3 1139.1 6347.1 6383.5 6403.7 6412.3 6417.9 6827.3 6848.1 6870.7 6874.7 6882.4 6395.6 6397.7 6404.7 6412.0 6415.7 3823.9 3835.1 3859.8 3860.1 3865.8 7195.7 7245.2 7247.6 7263.3 7266.0 7070.2 7201.7 7253.7 7256.4 7263.5 7175.2 7177.5 7219.7 7230.7 7266.7 7015.4 7069.7 7091.3 7102.1 7107.8 6742.9 6916.5 6935.4 6989.7 7001.9 7277.6 7287.2 7292.1 7295.8 7302.3 4694.7 4712.1 4719.5 4745.2 4747.1 6867.4 6923.8 7044.0 7073.9 7075.5 6798.0 6821.9 6830.4 6850.3 6866.6 6820.8 6822.7 6850.9 6854.6 6876.1 6590.3 6724.4 6730.8 6747.9 6753.2 6877.8 6880.0 6908.4 6912.2 6913.1 6670.5 6672.3 6700.4 6704.8 6713.6 11:10:05 INFO - 2015-12-18 11:10:05,527 DEBUG : BROWSER_OUTPUT: 11:10:05 INFO - 2015-12-18 11:10:05,527 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13405.93 Median:46804.27 stddev:15571.93 (33.3%) stddev-sans-first:15586.68 11:10:05 INFO - 2015-12-18 11:10:05,527 DEBUG : BROWSER_OUTPUT: Values: 764.5 822.5 825.7 842.1 848.1 13573.3 13736.6 13820.9 13874.5 13888.4 13169.7 13211.5 13635.7 13696.1 13703.2 776.3 780.9 785.3 799.8 805.2 792.1 795.8 797.7 798.7 798.8 827.2 836.0 837.9 839.7 843.2 818.6 826.4 826.7 830.9 831.6 607.6 608.0 609.1 609.1 610.1 13921.7 13958.2 13974.9 14035.5 14073.2 11567.7 11982.8 12015.3 12025.0 12186.4 10316.4 10439.8 10464.9 10507.3 10667.4 3582.1 3593.1 3698.9 3708.7 3716.6 47851.0 48210.3 48254.0 48404.5 48558.3 9875.6 10043.8 10078.3 10330.8 10438.4 15594.0 15606.8 15628.1 15633.6 15638.9 7244.5 7250.0 7274.7 7519.5 7539.5 3905.1 4122.8 4230.4 4350.2 4433.6 2908.1 2919.1 2934.4 2937.1 2943.2 526.5 531.9 536.9 546.7 549.3 613.4 643.2 654.3 675.8 676.8 8232.5 8379.5 8521.1 8563.1 8598.9 544.8 572.3 684.7 686.5 693.9 3823.3 4077.1 4098.4 4123.8 4146.9 53335.7 53815.0 53835.2 54102.5 54197.2 49945.3 50107.7 50602.7 50607.5 51191.0 45430.3 45785.1 45935.0 46549.5 47059.0 8024.3 8059.6 8155.0 8294.3 8307.8 34122.0 34202.8 34565.5 34677.0 34847.0 42398.6 43482.8 44036.3 44262.3 44335.8 9920.5 9999.9 10248.4 10264.0 10511.2 10763.1 10808.9 10989.6 11277.8 11344.5 10323.0 10335.1 10711.6 10716.8 10771.7 10246.8 10311.8 10386.3 10440.7 10568.8 10293.8 10376.0 10575.3 10575.5 10710.3 8814.4 8946.5 8959.3 9518.5 9524.7 8704.0 8844.4 9100.8 9183.7 9228.0 11:10:05 INFO - 2015-12-18 11:10:05,527 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:10:05 INFO - 2015-12-18 11:10:05,528 DEBUG : BROWSER_OUTPUT: 11:10:06 INFO - 2015-12-18 11:10:06,225 INFO : Browser exited with error code: 0 11:10:06 INFO - 2015-12-18 11:10:06,249 INFO : Completed test dromaeo_css (00:18:30) 11:10:06 INFO - 2015-12-18 11:10:06,249 INFO : Starting test kraken 11:10:06 INFO - 2015-12-18 11:10:06,249 DEBUG : operating with platform_type : linux_ 11:10:06 INFO - 2015-12-18 11:10:06,249 INFO : Initialising browser for kraken test... 11:10:06 INFO - 2015-12-18 11:10:06,255 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfTIExk/profile http://localhost:55092/getInfo.html 11:10:10 INFO - 2015-12-18 11:10:10,394 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:10:10 INFO - 2015-12-18 11:10:10,394 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:10:10 INFO - 2015-12-18 11:10:10,394 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:10:10 INFO - 2015-12-18 11:10:10,394 DEBUG : BROWSER_OUTPUT: __metrics 11:10:10 INFO - 2015-12-18 11:10:10,503 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:10:11 INFO - 2015-12-18 11:10:11,345 INFO : Browser initialized. 11:10:11 INFO - 2015-12-18 11:10:11,346 INFO : Running cycle 1/1 for kraken test... 11:10:11 INFO - 2015-12-18 11:10:11,346 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfTIExk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:10:23 INFO - 2015-12-18 11:10:23,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 150945792 11:10:23 INFO - 2015-12-18 11:10:23,167 DEBUG : BROWSER_OUTPUT: 11:10:25 INFO - 2015-12-18 11:10:25,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55092/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:26 INFO - 2015-12-18 11:10:26,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 152662016 11:10:26 INFO - 2015-12-18 11:10:26,291 DEBUG : BROWSER_OUTPUT: 11:10:28 INFO - 2015-12-18 11:10:28,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55092/tests/kraken/driver.html?testName=audio-dft) 11:10:29 INFO - 2015-12-18 11:10:29,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 151756800 11:10:29 INFO - 2015-12-18 11:10:29,502 DEBUG : BROWSER_OUTPUT: 11:10:32 INFO - 2015-12-18 11:10:32,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55092/tests/kraken/driver.html?testName=audio-fft) 11:10:32 INFO - 2015-12-18 11:10:32,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 146239488 11:10:32 INFO - 2015-12-18 11:10:32,915 DEBUG : BROWSER_OUTPUT: 11:10:34 INFO - 2015-12-18 11:10:34,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55092/tests/kraken/driver.html?testName=audio-oscillator) 11:10:35 INFO - 2015-12-18 11:10:35,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 145760256 11:10:35 INFO - 2015-12-18 11:10:35,529 DEBUG : BROWSER_OUTPUT: 11:10:37 INFO - 2015-12-18 11:10:37,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55092/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:38 INFO - 2015-12-18 11:10:38,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 146776064 11:10:38 INFO - 2015-12-18 11:10:38,295 DEBUG : BROWSER_OUTPUT: 11:10:41 INFO - 2015-12-18 11:10:41,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55092/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:41 INFO - 2015-12-18 11:10:41,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 147537920 11:10:41 INFO - 2015-12-18 11:10:41,856 DEBUG : BROWSER_OUTPUT: 11:10:45 INFO - 2015-12-18 11:10:45,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55092/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:45 INFO - 2015-12-18 11:10:45,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 148385792 11:10:45 INFO - 2015-12-18 11:10:45,782 DEBUG : BROWSER_OUTPUT: 11:10:48 INFO - 2015-12-18 11:10:48,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55092/tests/kraken/driver.html?testName=json-parse-financial) 11:10:49 INFO - 2015-12-18 11:10:49,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 148942848 11:10:49 INFO - 2015-12-18 11:10:49,166 DEBUG : BROWSER_OUTPUT: 11:10:50 INFO - 2015-12-18 11:10:50,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55092/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:10:51 INFO - 2015-12-18 11:10:51,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 148721664 11:10:51 INFO - 2015-12-18 11:10:51,328 DEBUG : BROWSER_OUTPUT: 11:10:53 INFO - 2015-12-18 11:10:53,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55092/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:53 INFO - 2015-12-18 11:10:53,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 148000768 11:10:53 INFO - 2015-12-18 11:10:53,780 DEBUG : BROWSER_OUTPUT: 11:10:55 INFO - 2015-12-18 11:10:55,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55092/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:10:56 INFO - 2015-12-18 11:10:56,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 148459520 11:10:56 INFO - 2015-12-18 11:10:56,432 DEBUG : BROWSER_OUTPUT: 11:10:58 INFO - 2015-12-18 11:10:58,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:10:59 INFO - 2015-12-18 11:10:59,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 149004288 11:10:59 INFO - 2015-12-18 11:10:59,477 DEBUG : BROWSER_OUTPUT: 11:11:02 INFO - 2015-12-18 11:11:02,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:02 INFO - 2015-12-18 11:11:02,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 148533248 11:11:02 INFO - 2015-12-18 11:11:02,666 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55092/tests/kraken/driver.html?testName=ai-astar) 11:11:04 INFO - 2015-12-18 11:11:04,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 149278720 11:11:04 INFO - 2015-12-18 11:11:04,621 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,621 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:11:04 INFO - 2015-12-18 11:11:04,621 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:11:04 INFO - 2015-12-18 11:11:04,621 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:11:04 INFO - 2015-12-18 11:11:04,621 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:11:04 INFO - 2015-12-18 11:11:04,621 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;112;113;113;123;112;112;112;113 11:11:04 INFO - 2015-12-18 11:11:04,621 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;134;150;162;124;152;151;129;160;125 11:11:04 INFO - 2015-12-18 11:11:04,621 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;161;162;162;159;162;174;162 11:11:04 INFO - 2015-12-18 11:11:04,622 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;71;73;73;131;72;77;70;72 11:11:04 INFO - 2015-12-18 11:11:04,622 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;133;93;94;92;139;93;93;137 11:11:04 INFO - 2015-12-18 11:11:04,622 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;110;110;109;109;110;109 11:11:04 INFO - 2015-12-18 11:11:04,622 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;146;146;147;146;147;146 11:11:04 INFO - 2015-12-18 11:11:04,622 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;96;96;97;96;97;96 11:11:04 INFO - 2015-12-18 11:11:04,622 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;59;59;60;62;60;65;57;58 11:11:04 INFO - 2015-12-18 11:11:04,622 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;67;68;67;68;68;68;67;68 11:11:04 INFO - 2015-12-18 11:11:04,622 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;92;84;84;87;85;84;86;85;87 11:11:04 INFO - 2015-12-18 11:11:04,622 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;119;122;120;117;120;124;127;122;125 11:11:04 INFO - 2015-12-18 11:11:04,623 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;165;154;150;151;143;152;153;143;146 11:11:04 INFO - 2015-12-18 11:11:04,623 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;69;67;71;68;68;69;68;68 11:11:04 INFO - 2015-12-18 11:11:04,623 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:11:04 INFO - 2015-12-18 11:11:04,623 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:11:04 INFO - 2015-12-18 11:11:04,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,709 11:11:04 INFO - 2015-12-18 11:11:04,623 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:11:04 INFO - 2015-12-18 11:11:04,623 DEBUG : BROWSER_OUTPUT: __startTimestamp1450465864616__endTimestamp 11:11:04 INFO - 2015-12-18 11:11:04,623 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,623 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:11:04 INFO - 2015-12-18 11:11:04,624 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:11:04 INFO - 2015-12-18 11:11:04,624 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,624 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:3.96 (3.5%) stddev-sans-first:4.18 11:11:04 INFO - 2015-12-18 11:11:04,624 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 112.0 113.0 113.0 123.0 112.0 112.0 112.0 113.0 11:11:04 INFO - 2015-12-18 11:11:04,624 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,625 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.80 Median:151.00 stddev:14.39 (9.5%) stddev-sans-first:15.02 11:11:04 INFO - 2015-12-18 11:11:04,625 DEBUG : BROWSER_OUTPUT: Values: 151.0 134.0 150.0 162.0 124.0 152.0 151.0 129.0 160.0 125.0 11:11:04 INFO - 2015-12-18 11:11:04,625 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,625 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:4.12 (2.5%) stddev-sans-first:4.32 11:11:04 INFO - 2015-12-18 11:11:04,626 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 161.0 162.0 162.0 159.0 162.0 174.0 162.0 11:11:04 INFO - 2015-12-18 11:11:04,626 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,626 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.60 Median:73.00 stddev:18.51 (25.4%) stddev-sans-first:19.52 11:11:04 INFO - 2015-12-18 11:11:04,626 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 71.0 73.0 73.0 131.0 72.0 77.0 70.0 72.0 11:11:04 INFO - 2015-12-18 11:11:04,626 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,626 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:93.00 stddev:20.99 (22.6%) stddev-sans-first:21.73 11:11:04 INFO - 2015-12-18 11:11:04,626 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 133.0 93.0 94.0 92.0 139.0 93.0 93.0 137.0 11:11:04 INFO - 2015-12-18 11:11:04,626 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,626 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 110.0 110.0 109.0 109.0 110.0 109.0 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.50 stddev:2.25 (3.7%) stddev-sans-first:2.37 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 59.0 59.0 60.0 62.0 60.0 65.0 57.0 58.0 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 67.0 68.0 67.0 68.0 68.0 68.0 67.0 68.0 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:2.42 (2.8%) stddev-sans-first:2.55 11:11:04 INFO - 2015-12-18 11:11:04,627 DEBUG : BROWSER_OUTPUT: Values: 85.0 92.0 84.0 84.0 87.0 85.0 84.0 86.0 85.0 87.0 11:11:04 INFO - 2015-12-18 11:11:04,628 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,628 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.00 stddev:3.95 (3.2%) stddev-sans-first:3.15 11:11:04 INFO - 2015-12-18 11:11:04,628 DEBUG : BROWSER_OUTPUT: Values: 130.0 119.0 122.0 120.0 117.0 120.0 124.0 127.0 122.0 125.0 11:11:04 INFO - 2015-12-18 11:11:04,628 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,628 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:152.50 stddev:6.44 (4.2%) stddev-sans-first:6.74 11:11:04 INFO - 2015-12-18 11:11:04,628 DEBUG : BROWSER_OUTPUT: Values: 154.0 165.0 154.0 150.0 151.0 143.0 152.0 153.0 143.0 146.0 11:11:04 INFO - 2015-12-18 11:11:04,628 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,628 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 11:11:04 INFO - 2015-12-18 11:11:04,628 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 69.0 67.0 71.0 68.0 68.0 69.0 68.0 68.0 11:11:04 INFO - 2015-12-18 11:11:04,629 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:11:04 INFO - 2015-12-18 11:11:04,629 DEBUG : BROWSER_OUTPUT: 11:11:05 INFO - 2015-12-18 11:11:05,449 INFO : Browser exited with error code: 0 11:11:05 INFO - 2015-12-18 11:11:05,499 INFO : Completed test kraken (00:00:59) 11:11:05 INFO - 2015-12-18 11:11:05,499 INFO : Starting test v8_7 11:11:05 INFO - 2015-12-18 11:11:05,499 DEBUG : operating with platform_type : linux_ 11:11:05 INFO - 2015-12-18 11:11:05,500 INFO : Initialising browser for v8_7 test... 11:11:05 INFO - 2015-12-18 11:11:05,506 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph6lAJ0/profile http://localhost:55092/getInfo.html 11:11:09 INFO - 2015-12-18 11:11:09,683 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:11:09 INFO - 2015-12-18 11:11:09,683 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:11:09 INFO - 2015-12-18 11:11:09,683 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:11:09 INFO - 2015-12-18 11:11:09,683 DEBUG : BROWSER_OUTPUT: __metrics 11:11:09 INFO - 2015-12-18 11:11:09,792 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:11:10 INFO - 2015-12-18 11:11:10,629 INFO : Browser initialized. 11:11:10 INFO - 2015-12-18 11:11:10,630 INFO : Running cycle 1/1 for v8_7 test... 11:11:10 INFO - 2015-12-18 11:11:10,630 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph6lAJ0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:11:22 INFO - 2015-12-18 11:11:22,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 150679552 11:11:22 INFO - 2015-12-18 11:11:22,390 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55092/tests/v8_7/run.html (next: http://localhost:55092/tests/v8_7/run.html) 11:11:43 INFO - 2015-12-18 11:11:43,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 146309120 11:11:43 INFO - 2015-12-18 11:11:43,965 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,966 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:11:43 INFO - 2015-12-18 11:11:43,967 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:11:43 INFO - 2015-12-18 11:11:43,967 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:11:43 INFO - 2015-12-18 11:11:43,967 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:11:43 INFO - 2015-12-18 11:11:43,967 DEBUG : BROWSER_OUTPUT: |0;Richards;167.6727028839705 11:11:43 INFO - 2015-12-18 11:11:43,967 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.32568985619898 11:11:43 INFO - 2015-12-18 11:11:43,967 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.4467120181406 11:11:43 INFO - 2015-12-18 11:11:43,967 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 11:11:43 INFO - 2015-12-18 11:11:43,968 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1046.0251046025105 11:11:43 INFO - 2015-12-18 11:11:43,968 DEBUG : BROWSER_OUTPUT: |5;Earley;701.2622720897616 11:11:43 INFO - 2015-12-18 11:11:43,968 DEBUG : BROWSER_OUTPUT: |6;Boyer;12108.43373493976 11:11:43 INFO - 2015-12-18 11:11:43,968 DEBUG : BROWSER_OUTPUT: |7;RegExp;25225 11:11:43 INFO - 2015-12-18 11:11:43,968 DEBUG : BROWSER_OUTPUT: |8;Splay;619.9628022318661 11:11:43 INFO - 2015-12-18 11:11:43,968 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 11:11:43 INFO - 2015-12-18 11:11:43,969 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:11:43 INFO - 2015-12-18 11:11:43,969 DEBUG : BROWSER_OUTPUT: __startTimestamp1450465903965__endTimestamp 11:11:43 INFO - 2015-12-18 11:11:43,969 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,969 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:11:43 INFO - 2015-12-18 11:11:43,969 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:11:43 INFO - 2015-12-18 11:11:43,969 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,969 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.67 Median:167.67 stddev:0.00 (0.0%) 11:11:43 INFO - 2015-12-18 11:11:43,969 DEBUG : BROWSER_OUTPUT: Values: 167.7 11:11:43 INFO - 2015-12-18 11:11:43,969 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.33 Median:194.33 stddev:0.00 (0.0%) 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: Values: 194.3 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.45 Median:283.45 stddev:0.00 (0.0%) 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: Values: 283.4 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: Values: 5148.7 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1046.03 Median:1046.03 stddev:0.00 (0.0%) 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: Values: 1046.0 11:11:43 INFO - 2015-12-18 11:11:43,970 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,971 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:701.26 Median:701.26 stddev:0.00 (0.0%) 11:11:43 INFO - 2015-12-18 11:11:43,971 DEBUG : BROWSER_OUTPUT: Values: 701.3 11:11:43 INFO - 2015-12-18 11:11:43,971 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,971 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 11:11:43 INFO - 2015-12-18 11:11:43,972 DEBUG : BROWSER_OUTPUT: Values: 12108.4 11:11:43 INFO - 2015-12-18 11:11:43,972 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,972 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25225.00 Median:25225.00 stddev:0.00 (0.0%) 11:11:43 INFO - 2015-12-18 11:11:43,972 DEBUG : BROWSER_OUTPUT: Values: 25225.0 11:11:43 INFO - 2015-12-18 11:11:43,972 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,972 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.96 Median:619.96 stddev:0.00 (0.0%) 11:11:43 INFO - 2015-12-18 11:11:43,972 DEBUG : BROWSER_OUTPUT: Values: 620.0 11:11:43 INFO - 2015-12-18 11:11:43,973 DEBUG : BROWSER_OUTPUT: 11:11:43 INFO - 2015-12-18 11:11:43,973 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:11:43 INFO - 2015-12-18 11:11:43,973 DEBUG : BROWSER_OUTPUT: Values: 4826.9 11:11:43 INFO - 2015-12-18 11:11:43,973 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:11:43 INFO - 2015-12-18 11:11:43,973 DEBUG : BROWSER_OUTPUT: 11:11:44 INFO - 2015-12-18 11:11:44,769 INFO : Browser exited with error code: 0 11:11:44 INFO - 2015-12-18 11:11:44,786 INFO : Completed test v8_7 (00:00:39) 11:11:45 INFO - 2015-12-18 11:11:45,031 INFO : Completed test suite (00:20:09) 11:11:45 INFO - 2015-12-18 11:11:45,031 DEBUG : Working with test: dromaeo_css 11:11:45 INFO - 2015-12-18 11:11:45,031 DEBUG : Generating results file: dromaeo_css 11:11:45 INFO - 2015-12-18 11:11:45,033 DEBUG : Working with test: kraken 11:11:45 INFO - 2015-12-18 11:11:45,033 DEBUG : Generating results file: kraken 11:11:45 INFO - 2015-12-18 11:11:45,033 INFO : javascript benchmark 11:11:45 INFO - 2015-12-18 11:11:45,033 DEBUG : Working with test: v8_7 11:11:45 INFO - 2015-12-18 11:11:45,033 DEBUG : Generating results file: v8_7 11:11:45 INFO - 2015-12-18 11:11:45,034 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:45 INFO - 2015-12-18 11:11:45,087 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:11:45 INFO - 2015-12-18 11:11:45,087 DEBUG : process_Request line: dromaeo_css 6872.39 graph.html#tests=[[72,64,43]] 11:11:45 INFO - 2015-12-18 11:11:45,087 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:45 INFO - 2015-12-18 11:11:45,115 DEBUG : process_Request line: kraken 1512.60 graph.html#tests=[[232,64,43]] 11:11:45 INFO - 2015-12-18 11:11:45,116 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:45 INFO - 2015-12-18 11:11:45,150 DEBUG : process_Request line: v8_7 21335.48 graph.html#tests=[[230,64,43]] 11:11:45 INFO - 2015-12-18 11:11:45,151 INFO : javascript benchmark 11:11:45 INFO - 2015-12-18 11:11:45,155 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3179.205198700325, 3211.470107432274, 3238.271388937491, 3253.0403530958365, 3265.8203798791073, 5226.477352264772, 5294.232336311233, 5334.91997620036, 5349.786008559653, 5352.598555108363, 5289.761960711768, 5325.547328477074, 5325.866853328669, 5345.49217824307, 5419.430959749228, 4901.142300097486, 4914.97542512287, 4928.987067361827, 4940.580050695695, 5070.923936140961, 5050.444451110375, 5073.670211436245, 5109.591232701394, 5125.487451254863, 5132.589392848563, 4753.762311884409, 4843.612510999129, 4851.393575803025, 4862.027594481083, 4880.170371036932, 4805.663603547753, 4887.511248875119, 4893.804247830082, 4912.631552633567, 4915.041566894457, 4844.079624871263, 4873.926891096601, 4877.487863774288, 4911.803527858881, 4929.383827021622, 5074.238864170367, 5177.119889618773, 5197.454267301954, 5229.294045303911, 5249.291345668324, 5653.434656534355, 5704.71476426177, 5806.738696758656, 5913.142594323799, 5941.405859414067, 5875.676837773921, 5887.7939272125695, 5891.293044834647, 5903.0, 5919.2009078774245, 5502.367227768817, 5509.201165830972, 5512.3936367, 5512.80705175317, 5518.117101263819, 5833.270841144857, 5847.502962248172, 5882.058870580687, 5918.7928422505, 5923.17075609415, 5675.4324567543745, 5729.914051289234, 5738.340090889601, 5749.626274292157, 5781.046127388934, 5542.5565954723525, 5796.565257605696, 5813.82558523245, 5818.709064546756, 5854.648721076749, 5721.342045664802, 5819.912701309484, 5914.8817023659285, 5924.5852790305125, 5979.19280897082, 5733.168690539932, 5737.741801618937, 5746.683932383759, 5771.913421298684, 5773.134029895466, 4358.760268185217, 4429.712068715523, 4476.888077798081, 4482.731036137842, 4513.029698614813, 3926.764394136361, 3950.7827069511454, 3952.407138929126, 3969.6625786807867, 3981.124152686404, 5519.530839878575, 5519.834404967857, 5524.116141417354, 5535.529479994165, 5555.361133469622, 5680.431956804369, 5738.397468265772, 5852.122181672698, 5863.442972917566, 5889.116632505158, 5532.474414930575, 5539.723013849291, 5561.860953476195, 5565.41563135873, 5570.61005729595, 5025.4974502550185, 5055.797768089309, 5056.999999999926, 5057.31726216956, 5094.745262736922, 5818.156367326798, 5850.678212698257, 5915.201447804578, 5917.082852157922, 5954.55340849438, 5742.626729262752, 5805.129230615442, 5807.274090738658, 5845.590808643524, 5855.180274761452, 5955.047192449188, 5972.581919265784, 5979.790707325223, 5981.730822112929, 5993.580449368503, 5571.303587051619, 5663.433656634304, 5757.222774925499, 5851.297844258716, 5888.587798854039, 5733.799317023884, 5775.191473193672, 5783.16144159103, 5788.305403351625, 5793.449622285876, 5481.972590137024, 5599.0, 5656.321241451053, 5660.037793575019, 5668.801591944262, 5486.094794358886, 5629.211910332639, 5693.345265294379, 5694.629849059798, 5722.141678748221, 5639.7180140993605, 5642.266505354278, 5654.321481422256, 5658.20785090096, 5678.20505129274, 5664.461876121762, 5772.018756811436, 5788.131780232999, 5809.82570522885, 5833.79581714638, 5435.972820135874, 5512.80705175317, 5524.889502210013, 5526.696031718133, 5554.777808887599], "unit": "score", "name": "dojo.html", "value": 5345.317140147767}, {"lowerIsBetter": false, "replicates": [553.2531083037896, 561.7247548701138, 568.247072628767, 568.8037627018679, 575.3010092737323, 37384.81307593462, 38139.427908581325, 38142.8092859536, 38167.236655266875, 38314.42528362073, 42187.367189492106, 42767.57232427675, 43019.139617207635, 43048.13903721931, 43085.35371969423, 8550.444221125637, 8698.39111262212, 8701.521416322099, 8713.3464990126, 8721.30229581632, 8508.064112947572, 8530.23227909488, 8585.441946273504, 8587.570621468933, 8611.26804221642, 8568.700095496659, 8616.956915215414, 8619.569021548929, 8701.695440659578, 8703.260222881063, 8595.398322117455, 8610.741677749678, 8632.007319158283, 8666.52334121623, 8698.304135669163, 8457.407981441302, 8528.573571321409, 8539.35954803386, 8569.143085691443, 8609.784755381103, 38870.80564597187, 39006.60993390058, 39246.0, 39256.60743392586, 39312.410313845314, 3265.951010734841, 3334.9666503334897, 3591.730620203495, 3597.5503062117236, 3846.268909741817, 29356.266093347836, 29720.70279297201, 29885.655145518504, 30087.548686769715, 30098.398032039237, 3835.827387767557, 3942.7831469269177, 4009.83960641574, 4047.4131250968444, 4101.692373072032, 254776.0, 254908.0, 255827.0, 255901.0, 255903.72048139825, 55391.44608553863, 55558.72220638871, 55715.44284557102, 55789.0, 55986.0, 58458.0, 58755.0, 59899.0, 60283.0, 67192.0, 13707.520236791665, 13716.902647788153, 13808.378622961991, 13809.792853107212, 13811.723765524634, 10669.306495077795, 10714.19643526723, 10717.035466808025, 10768.515416806262, 10772.407517586607, 19159.233630654617, 19345.51636209106, 19415.902920485307, 19479.318223862098, 19491.317803876795, 7310.890336644955, 7459.776206713807, 7488.925110748823, 7559.470837041465, 7600.594638278391, 922.6032805893531, 937.5406051034944, 968.3415277611151, 1011.4740335025892, 1067.524951396621, 28016.85991570029, 28035.43929121447, 28180.718192818218, 28485.430291394056, 28595.428091438054, 1031.4997226345217, 1069.9411532365639, 1071.7106381277013, 1101.9118769930935, 1140.994295028536, 13483.528076517276, 13588.796168057486, 13856.93071534656, 13893.722125557635, 14349.713005739826, 295928.0, 299475.0, 299602.0, 299645.0, 299834.0, 49306.75346623316, 49732.0, 49806.252906206435, 49885.50114498881, 49903.0, 1328.9401976911063, 1334.9920809788741, 1338.3977210255423, 1342.536824795444, 1360.1634994478325, 26488.470230594896, 27028.594571081056, 27131.86434067896, 27456.45087098287, 27556.862215688794, 44637.33044004277, 44866.55133448754, 44951.775241123585, 45045.54954450545, 45112.54887451084, 287045.0, 290077.0, 291165.0, 292343.0, 292364.0, 30298.545521817632, 31590.842045789625, 31615.84192079117, 31854.522182166824, 32040.5193922096, 35983.82008090048, 36724.44913326356, 36966.630333697394, 37205.255894882495, 37539.49842006289, 32115.67884321127, 33027.00918972435, 34103.0, 34295.971120866416, 34548.48177277393, 34340.31319373648, 34678.82660586681, 37437.81281093686, 37792.62207378001, 38205.0, 33763.0, 33869.15327116842, 33918.491222631186, 34143.0, 34218.315633687685, 30778.230544236572, 31051.844740776152, 31400.214994625316, 31533.36933261276, 31545.842270789417, 24179.15372961938, 24349.634755478328, 24547.877260613583, 24785.380365491008, 24858.129965451124], "unit": "score", "name": "ext.html", "value": 17969.678669605706}, {"lowerIsBetter": false, "replicates": [361.1278761790276, 361.1332801276935, 361.79739345966277, 361.84621535847276, 367.03835949811497, 16282.26729797159, 16953.237104330303, 17452.47642570725, 17485.0, 17961.550961225978, 15616.45342413013, 15725.60685982851, 15801.288941997609, 15857.524274271791, 16099.0, 4960.330355402019, 5108.157154069574, 5113.258577506259, 5121.3342265505435, 5126.794928202868, 4992.375953005874, 5081.466446023152, 5100.387953445592, 5122.795088196468, 5124.538791508763, 5058.418281897573, 5088.720120393377, 5171.2760213569945, 5312.654677445973, 5319.3616765987945, 4947.431045429786, 5289.709066001368, 5306.628536002481, 5357.624966252364, 5590.720463976785, 5392.352917649868, 5393.622446428752, 5396.514313711785, 5408.0535906216255, 5431.9185212221455, 12707.491700331975, 14297.78553321701, 16825.822192446532, 20665.0, 20750.688739668916, 2104.95790084199, 2106.2680867567656, 2119.5548934723724, 2150.9890351534755, 2229.320057382498, 9257.768555786091, 9672.371295865747, 10992.670219893416, 13107.34463276842, 13483.19100853952, 1787.356551641421, 1846.18767742193, 1846.704527275643, 1911.7419148414924, 1915.4732448576613, 62241.4203059364, 62582.0, 63352.0, 65484.67257663681, 65543.01685474721, 10056.094951454257, 10229.590816367261, 10239.334443261165, 10311.381317120997, 10336.793264134676, 13490.662733431744, 13548.390322435514, 13551.051426400254, 13551.39018744159, 13555.457781688621, 6878.449724022066, 6895.75864844738, 6998.440124790005, 7160.713571457188, 7164.104486939133, 6724.731010759613, 6793.592384456949, 6807.523473356818, 6870.484713646497, 6875.621840798804, 4250.596193361625, 4295.548967358445, 4329.978350108292, 4330.2205602991135, 4421.4915284742665, 1626.9755953660704, 1755.5172327609755, 1811.0, 1819.2631984046482, 1837.7151541511087, 832.2385017708729, 922.280621115531, 989.7080361293292, 1010.6462738041773, 1016.2885979814012, 16439.178041097897, 17266.0, 17521.474355769093, 17600.295988160586, 18178.727319090223, 900.1178844732199, 931.8648795924553, 934.6261495401893, 962.2975228083538, 972.8054389122204, 9002.819943601222, 9120.179183873483, 9200.355975081813, 9211.032841551674, 9294.767630809283, 141591.0, 144434.5556544421, 144618.0, 524344.0, 526966.0, 81439.0, 82083.17916820756, 82673.0, 84009.15990840136, 84084.15915840886, 1109.6060898380958, 1128.4990962020656, 1130.6155906991662, 1149.4540093455541, 1156.5200441816721, 14921.701565968837, 15092.320845561757, 15093.698126037638, 15155.545333640008, 15516.612084697972, 33022.76294348759, 35276.29447410986, 35656.82171589125, 36041.0989725259, 36156.4576531347, 47048.54611256708, 47670.52329476661, 47688.761556191996, 48711.75644121757, 51059.48940510696, 9092.0, 9248.907510925073, 9262.675806347015, 9298.95350523243, 9337.20633746112, 10829.51267192994, 13721.588352349445, 17742.20160092825, 17971.820281797016, 18376.724349135042, 13536.661583460493, 13821.723565528835, 13865.584032479042, 14657.48698795537, 14689.41242350294, 13902.51341203053, 14082.577522674335, 14304.642383940485, 14528.128312301296, 14564.85435145635, 14261.42954281817, 14366.56900292993, 14728.26358682083, 14740.262986850401, 14804.259787010391, 9565.139137477661, 9578.712638620853, 9991.750206244902, 9992.550335235077, 10103.898961010296, 11485.712857178638, 15041.473548426191, 15156.848431515544, 15209.315580799112, 15278.618034548781], "unit": "score", "name": "jquery.html", "value": 8673.626371498953}, {"lowerIsBetter": false, "replicates": [1423.238567366459, 1493.096676510711, 1591.7930669013026, 1594.9043057416548, 1722.1905704318965, 6331.873362532758, 6393.0, 6978.790636280907, 7428.6657100430475, 7445.888311675322, 6559.0, 6765.12053433053, 7041.15506139264, 7202.387797037245, 7219.0976127984, 2089.9895500522516, 2128.744550653916, 2134.3170185540635, 2145.678148277763, 2149.892505374733, 2112.039022244875, 2136.604728125294, 2164.404788683109, 2179.509610337669, 2182.5853087913324, 2086.2698055680544, 2126.723525941633, 2136.166894910986, 2178.2376168341034, 2185.071344678513, 2129.55279391328, 2157.4067131538873, 2180.7819218078225, 2180.967285490719, 2183.62878310686, 2057.6296266671993, 2096.8846713430753, 2117.110813458351, 2117.6400011998, 2118.0257081742416, 7286.672099755524, 7357.190709022003, 7358.448116391239, 7370.96314518424, 7386.704531818775, 4305.56944305567, 4403.471583409979, 4407.206702793496, 4407.405000324947, 4420.690551661385, 2910.57796619489, 2951.6605590357167, 2954.7340739333563, 2973.68776278492, 2982.970170298291, 966.9033096690345, 969.5927710361665, 984.2814745236018, 1009.545704433008, 1021.4637315409395, 9307.39501932379, 9480.288978326584, 9504.762380940463, 9507.809843803085, 9507.952460237655, 3766.7174961877968, 3840.1743625120735, 3864.7101467390057, 3866.555346135174, 3879.321118804198, 8044.919550804417, 8058.0733215679775, 8123.47197432165, 8141.755747327589, 8158.67365305393, 4340.587644173798, 4373.081652852937, 4373.497047839539, 4406.889827754268, 4411.933820992687, 3933.5476420212044, 4038.9798051009557, 4053.5135783706146, 4055.7160998729805, 4092.3656833190903, 3295.060907641359, 3326.966730332714, 3327.068420842168, 3335.949960750591, 3358.697717205463, 1030.6598822388594, 1036.5231993283023, 1041.4896700616644, 1048.6120135549895, 1052.0531521630442, 939.7650587353162, 947.7583216279943, 949.7055912667096, 974.6198982396871, 1177.3583397048628, 6760.7295708172105, 6772.848615735337, 6787.04981302618, 6801.7619383322335, 6806.965965170142, 455.90426010537493, 466.5987250964168, 473.90521895621015, 477.5582586107906, 480.742802600607, 5404.594655400861, 5430.701311427831, 5431.538319242909, 5473.370562385297, 5476.151196564539, 8414.242718155396, 8433.325333973267, 8723.694670686622, 8767.123287671182, 8771.386002979858, 8589.44168629037, 8599.226069653636, 8648.524331161721, 8702.82594348122, 8717.869231961526, 6884.896726549106, 6908.792736217922, 6914.274001229899, 6934.930650693428, 7007.719691212396, 6664.333566643297, 6668.0, 6672.232693240146, 6673.332666733288, 6691.866162676816, 7342.596157211405, 7538.623068846426, 7578.12851522082, 7685.730999414994, 7737.264959828807, 7809.570473624005, 7844.529328240324, 7868.567228802471, 7877.566733829465, 7896.84206315859, 5591.329040515164, 5873.911891321548, 6589.439897608757, 6646.60120392778, 6650.035744817072, 6896.241413444617, 6924.272951340238, 6944.618046007518, 6959.095317608679, 6967.268436814062, 6343.207099112611, 6445.480649126476, 6529.575577587441, 6573.638449885302, 6583.3087525811015, 6526.771562995273, 6540.738370465128, 6575.901361479678, 6650.401463868275, 6657.0, 6473.158489396348, 6503.577267477599, 6518.837029074311, 6533.248676402274, 6537.803865884031, 5610.18652295423, 5817.825465236049, 5883.0881213411985, 5907.940920590739, 5918.704064796657, 6040.6979651018155, 6065.60573562717, 6075.483583895419, 6077.848053798691, 6117.388261174025], "unit": "score", "name": "mootools.html", "value": 4070.281131547989}, {"lowerIsBetter": false, "replicates": [340.0766917818123, 341.40765771386657, 346.5858299332297, 347.2343482620821, 348.20956428906385, 6216.067589861523, 6260.123582698426, 6318.0, 6356.777512787054, 6401.8399540011405, 6098.237720284965, 6232.563720539564, 6257.0, 6272.56092073555, 6274.498040156788, 4783.928241076378, 4805.687630304036, 4820.638452116088, 4824.300476430933, 4828.299896515004, 4831.347768051321, 4832.395950506187, 4834.613230941533, 4837.274408838684, 4845.200541910581, 4710.646701497384, 4786.234202527597, 4819.084373968953, 4824.300476430915, 4827.155247831633, 4788.0423915216925, 4803.759812009385, 4814.374131362935, 4816.7832447539595, 4823.807047718087, 4216.51510076342, 4230.746155230696, 4249.766262855542, 4258.318669012974, 4259.382389553529, 5958.374370691058, 5973.133895585159, 5985.910211346833, 6004.459598636144, 6015.909761353583, 5464.26232458621, 5608.691521966291, 5609.52319052881, 5612.326520817487, 5619.157126431027, 6638.93361066388, 6679.465642748569, 6690.431313338372, 6693.464522838161, 6693.732250710014, 4629.3750343703505, 4629.398178236841, 4637.698549594299, 4645.279981602857, 4651.3255577941345, 6838.076859623937, 6882.69027893746, 6903.516753827234, 6947.861042779116, 6967.09427774386, 4625.699329543569, 4641.930371044437, 4648.97675511627, 4653.86038418848, 4655.301704744315, 4688.296755486705, 4708.317293992352, 4717.009428020086, 4720.598749106364, 4725.669203155746, 5442.91835622466, 5484.588655850827, 5498.202760599771, 5506.972465137648, 5520.944790552124, 6526.151600291932, 6701.061851340816, 6728.158980127484, 6729.158855143107, 6746.763863264762, 1631.8776091793163, 1669.766232727419, 1672.1639180409795, 1674.1796519705256, 1675.2293944785292, 1073.4364458659265, 1105.8396532502902, 1110.2838669058413, 1117.273772048159, 1139.1342579639368, 6347.143135676717, 6383.457406120532, 6403.743850245938, 6412.294647588761, 6417.935820641827, 6827.317268273232, 6848.14398200225, 6870.725170993204, 6874.690638921261, 6882.380585747307, 6395.616263024233, 6397.6801159941815, 6404.7117879695525, 6412.006139048455, 6415.716856628693, 3823.9044023899623, 3835.1179228776978, 3859.826307816155, 3860.131470419133, 3865.8260378283044, 7195.676194571257, 7245.166805817293, 7247.637618119073, 7263.273672632695, 7265.963670181721, 7070.151581810215, 7201.675924583406, 7253.673584688701, 7256.383207427428, 7263.527870688388, 7175.17485489165, 7177.533460325167, 7219.747308844166, 7230.710771569184, 7266.745663901633, 7015.36861682451, 7069.681864316221, 7091.255418181223, 7102.112235970504, 7107.786766397016, 6742.898856517254, 6916.515843890879, 6935.410490108397, 6989.720411183699, 7001.929980700128, 7277.563346199245, 7287.2348403419, 7292.124945006633, 7295.781126566211, 7302.2697730226555, 4694.671373003857, 4712.057588482386, 4719.457262414729, 4745.193317136026, 4747.074320507468, 6867.381935625618, 6923.792286231421, 7044.049053377728, 7073.929260707533, 7075.540089894346, 6798.048273241651, 6821.863562728817, 6830.419414349637, 6850.349216824394, 6866.588004719732, 6820.761273355409, 6822.692978816064, 6850.903855383115, 6854.554453960476, 6876.106106206161, 6590.340965903371, 6724.394804467622, 6730.798076057726, 6747.898781518183, 6753.15585551806, 6877.828054298682, 6879.965600172167, 6908.378245957687, 6912.170539535288, 6913.10129683138, 6670.533062685759, 6672.266050734513, 6700.363465470772, 6704.832379190364, 6713.56361836479], "unit": "score", "name": "prototype.html", "value": 5063.095539248623}, {"lowerIsBetter": false, "replicates": [764.4648745877887, 822.4982760516087, 825.6944930375762, 842.1494290766328, 848.0501837941505, 13573.321333933302, 13736.58790236292, 13820.930895345535, 13874.514391996283, 13888.375023123972, 13169.670758231048, 13211.537596184135, 13635.659108522266, 13696.109752866081, 13703.246321452341, 776.2664282253273, 780.9062912450514, 785.2853902948318, 799.8240387114826, 805.1586092533288, 792.1207459719707, 795.7970717467067, 797.6928882380296, 798.7284323330067, 798.7883210949074, 827.210014436212, 835.9916400835974, 837.8868852704868, 839.6725277141919, 843.161054750524, 818.5825229133155, 826.3554427546524, 826.7437094500724, 830.8753686946945, 831.6049876308765, 607.6232735703848, 608.0089454189687, 609.0711664711306, 609.1259043272918, 610.1092405088576, 13921.651958701012, 13958.232297223649, 13974.860251397458, 14035.50875719345, 14073.225972571505, 11567.652970410902, 11982.820257696141, 12015.339156346397, 12025.0, 12186.390680465942, 10316.432596207205, 10439.843402348972, 10464.947675261652, 10507.317024393466, 10667.359958402521, 3582.140286331262, 3593.0658028912408, 3698.85204591816, 3708.7033037356946, 3716.572594151653, 47851.0, 48210.276845847344, 48254.0, 48404.51595484035, 48558.271625925285, 9875.555599998017, 10043.849342259871, 10078.294519383719, 10330.793384132276, 10438.425886576311, 15594.0, 15606.765898511532, 15628.062316261061, 15633.60915977087, 15638.9218053909, 7244.529105608224, 7249.96375018132, 7274.666773006818, 7519.473636845478, 7539.547627142389, 3905.1018265798457, 4122.7732474713575, 4230.428892099527, 4350.195213885441, 4433.645308375322, 2908.0984894682715, 2919.0658989123276, 2934.413117376533, 2937.1041832240944, 2943.234758962685, 526.5287567627029, 531.8829857431359, 536.8630999095205, 546.6528754241006, 549.3023859698161, 613.411125319698, 643.1606753187135, 654.2672207128047, 675.8344205669642, 676.8104930619435, 8232.547209903512, 8379.49723016621, 8521.147885211429, 8563.143685631512, 8598.87101693475, 544.77119609764, 572.3303734630492, 684.6645143879463, 686.5419911701989, 693.9063226464363, 3823.2544653792243, 4077.082656402345, 4098.405731168964, 4123.835046598162, 4146.937795933063, 53335.73332133392, 53815.0, 53835.19247211295, 54102.45897540974, 54197.1870421944, 49945.25082123771, 50107.74946125319, 50602.746986264836, 50607.49392506028, 51191.0, 45430.318545221846, 45785.08429831451, 45935.0, 46549.534504655196, 47059.0, 8024.317932975762, 8059.556724380215, 8154.959225203836, 8294.25351718324, 8307.83384332322, 34122.0, 34202.82898585491, 34565.48151777675, 34677.0, 34847.0, 42398.576014239465, 43482.78258608687, 44036.33945490884, 44262.33606495841, 44335.77832110819, 9920.503974801086, 9999.900001000187, 10248.38509689421, 10264.024917632813, 10511.159107271247, 10763.138948884227, 10808.945955270174, 10989.61536346224, 11277.830832537682, 11344.546218151181, 10323.0, 10335.121514671036, 10711.625093121704, 10716.785664286826, 10771.730706732395, 10246.846297305696, 10311.839980121755, 10386.272960892666, 10440.68677939663, 10568.841467377842, 10293.845592316271, 10376.009526039645, 10575.312604680672, 10575.524101415609, 10710.283895405899, 8814.427062240933, 8946.507942063248, 8959.328050396116, 9518.524073796421, 9524.714258572254, 8703.999040110468, 8844.380893337404, 9100.77248068777, 9183.678571249975, 9227.953860230657], "unit": "score", "name": "yui.html", "value": 6135.511714219837}], "name": "dromaeo_css", "value": 6872.3863187231445}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 112.0, 113.0, 113.0, 123.0, 112.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [151.0, 134.0, 150.0, 162.0, 124.0, 152.0, 151.0, 129.0, 160.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 159.0, 162.0, 174.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 71.0, 73.0, 73.0, 131.0, 72.0, 77.0, 70.0, 72.0], "unit": "score", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 133.0, 93.0, 94.0, 92.0, 139.0, 93.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 59.0, 59.0, 60.0, 62.0, 60.0, 65.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 84.0, 84.0, 87.0, 85.0, 84.0, 86.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [130.0, 119.0, 122.0, 120.0, 117.0, 120.0, 124.0, 127.0, 122.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [154.0, 165.0, 154.0, 150.0, 151.0, 143.0, 152.0, 153.0, 143.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 67.0, 71.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1512.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.6727028839705], "unit": "score", "name": "Richards", "value": 210.54112800000007}, {"lowerIsBetter": false, "replicates": [194.32568985619898], "unit": "score", "name": "DeltaBlue", "value": 340.2432279999999}, {"lowerIsBetter": false, "replicates": [283.4467120181406], "unit": "score", "name": "Encrypt", "value": 939.0865680000002}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1046.0251046025105], "unit": "score", "name": "RayTrace", "value": 707.4294840000001}, {"lowerIsBetter": false, "replicates": [701.2622720897616], "unit": "score", "name": "Earley", "value": 950.3762380000003}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [25225.0], "unit": "score", "name": "RegExp", "value": 36.11437066402381}, {"lowerIsBetter": false, "replicates": [619.9628022318661], "unit": "score", "name": "Splay", "value": 131.44498299999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21335.484030000895}]} 11:11:45 INFO - RETURN: dromaeo_css: 6872.39 11:11:45 INFO - RETURN: kraken: 1512.60 11:11:45 INFO - RETURN: v8_7: 21335.48 11:11:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21335.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1512.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6872.39"}}} 11:11:45 INFO - Return code: 0 11:11:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:11:45 INFO - # TBPL SUCCESS # 11:11:45 INFO - Running post-action listener: _resource_record_post_action 11:11:45 INFO - Running post-run listener: _resource_record_post_run 11:11:46 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 20480; Write bytes: 555962368; Read time: 60; Write time: 350752 11:11:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 233709568; Read time: 0; Write time: 184012 11:11:46 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 20480; Write bytes: 321388544; Read time: 60; Write time: 166696 11:11:46 INFO - Running post-run listener: _upload_blobber_files 11:11:46 INFO - Blob upload gear active. 11:11:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:11:46 INFO - Copying logs to upload dir... 11:11:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.526779 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-18 11:11:46.353384) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 11:11:46.361546) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009874 build_url: 'https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 11:11:46.411801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:11:46.412167) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450464236.329638-203570565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:11:46.468289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 11:11:46.468672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 11:11:46.469127) ========= ========= Total master_lag: 0.21 =========