builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1456545079.57 results: success (0) buildid: 20160226173019 builduid: 6e9b988346df471bba2aadcda3b04e74 revision: f3b3ade07154fe0bee9ecd02e15bbfe94ea74754 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.565497) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.565906) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.566182) ========= 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=232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009207 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.593201) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.593472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.607474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.607747) ========= 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=232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.655991) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.656252) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.656580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.656892) ========= 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=232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 19:51:20-- 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% 35.1M=0s 2016-02-26 19:51:20 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.828587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.828923) ========= 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=232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016761 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.880438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:19.880790) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f3b3ade07154fe0bee9ecd02e15bbfe94ea74754 --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 f3b3ade07154fe0bee9ecd02e15bbfe94ea74754 --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=232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 19:51:20,432 truncating revision to first 12 chars 2016-02-26 19:51:20,432 Setting DEBUG logging. 2016-02-26 19:51:20,432 attempt 1/10 2016-02-26 19:51:20,432 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f3b3ade07154?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 19:51:20,719 unpacking tar archive at: fx-team-f3b3ade07154/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603676 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:20.496554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:20.496869) ========= echo f3b3ade07154fe0bee9ecd02e15bbfe94ea74754 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f3b3ade07154fe0bee9ecd02e15bbfe94ea74754'] 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=232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f3b3ade07154fe0bee9ecd02e15bbfe94ea74754 program finished with exit code 0 elapsedTime=0.004199 script_repo_revision: 'f3b3ade07154fe0bee9ecd02e15bbfe94ea74754' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:20.546238) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:20.546528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 19:51:20.555792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-26 19:51:20.556054) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:51:21 INFO - MultiFileLogger online at 20160226 19:51:21 in /builds/slave/test-pgo 19:51:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:51:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:51:21 INFO - {'append_to_log': False, 19:51:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:51:21 INFO - 'blob_upload_branch': 'Fx-Team', 19:51:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:51:21 INFO - 'branch': 'Fx-Team', 19:51:21 INFO - 'buildbot_json_path': 'buildprops.json', 19:51:21 INFO - 'config_files': ('talos/linux_config.py',), 19:51:21 INFO - 'default_actions': ('clobber', 19:51:21 INFO - 'read-buildbot-config', 19:51:21 INFO - 'download-and-extract', 19:51:21 INFO - 'populate-webroot', 19:51:21 INFO - 'create-virtualenv', 19:51:21 INFO - 'install', 19:51:21 INFO - 'run-tests'), 19:51:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:51:21 INFO - 'download_minidump_stackwalk': True, 19:51:21 INFO - 'download_symbols': 'ondemand', 19:51:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:51:21 INFO - 'tooltool.py': '/tools/tooltool.py', 19:51:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:51:21 INFO - '/tools/misc-python/virtualenv.py')}, 19:51:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:51:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:51:21 INFO - 'installer_path': 'installer.exe', 19:51:21 INFO - 'log_level': 'info', 19:51:21 INFO - 'log_name': 'talos', 19:51:21 INFO - 'log_to_console': True, 19:51:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:51:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:51:21 INFO - 'opt_config_files': (), 19:51:21 INFO - 'pip_index': False, 19:51:21 INFO - 'sps_profile': False, 19:51:21 INFO - 'sps_profile_interval': 0, 19:51:21 INFO - 'suite': 'dromaeojs-e10s', 19:51:21 INFO - 'system_bits': '32', 19:51:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:51:21 INFO - 'title': 'talos-linux64-ix-025', 19:51:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:51:21 INFO - 'use_talos_json': True, 19:51:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:51:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:51:21 INFO - 'work_dir': 'build'} 19:51:21 INFO - ##### 19:51:21 INFO - ##### Running clobber step. 19:51:21 INFO - ##### 19:51:21 INFO - Running pre-action listener: _resource_record_pre_action 19:51:21 INFO - Running main action method: clobber 19:51:21 INFO - rmtree: /builds/slave/test-pgo/build 19:51:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:51:22 INFO - Running post-action listener: _resource_record_post_action 19:51:22 INFO - ##### 19:51:22 INFO - ##### Running read-buildbot-config step. 19:51:22 INFO - ##### 19:51:22 INFO - Running pre-action listener: _resource_record_pre_action 19:51:22 INFO - Running main action method: read_buildbot_config 19:51:22 INFO - Using buildbot properties: 19:51:22 INFO - { 19:51:22 INFO - "project": "", 19:51:22 INFO - "product": "firefox", 19:51:22 INFO - "script_repo_revision": "production", 19:51:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:51:22 INFO - "repository": "", 19:51:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:51:22 INFO - "buildid": "20160226173019", 19:51:22 INFO - "pgo_build": "True", 19:51:22 INFO - "basedir": "/builds/slave/test-pgo", 19:51:22 INFO - "buildnumber": 530, 19:51:22 INFO - "slavename": "talos-linux64-ix-025", 19:51:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:51:22 INFO - "platform": "ubuntu64_hw", 19:51:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:51:22 INFO - "branch": "fx-team", 19:51:22 INFO - "repo_path": "integration/fx-team", 19:51:22 INFO - "revision": "f3b3ade07154fe0bee9ecd02e15bbfe94ea74754", 19:51:22 INFO - "stage_platform": "linux64-pgo", 19:51:22 INFO - "builduid": "6e9b988346df471bba2aadcda3b04e74", 19:51:22 INFO - "slavebuilddir": "test" 19:51:22 INFO - } 19:51:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 19:51:22 INFO - Running post-action listener: _resource_record_post_action 19:51:22 INFO - ##### 19:51:22 INFO - ##### Running download-and-extract step. 19:51:22 INFO - ##### 19:51:22 INFO - Running pre-action listener: _resource_record_pre_action 19:51:22 INFO - Running main action method: download_and_extract 19:51:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:22 INFO - https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:51:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/test_packages.json 19:51:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/test_packages.json 19:51:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:51:28 INFO - Downloaded 1448 bytes. 19:51:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:51:28 INFO - Using the following test package requirements: 19:51:28 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:28 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:51:28 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:51:28 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:28 INFO - u'jsshell-linux-x86_64.zip'], 19:51:28 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:51:28 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:28 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:51:28 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:51:28 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:51:28 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:28 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:51:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:28 INFO - https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:51:29 INFO - Downloaded 23371646 bytes. 19:51:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:51:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:51:30 INFO - Return code: 0 19:51:30 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:30 INFO - https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:51:34 INFO - Downloaded 23371646 bytes. 19:51:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:51:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:51:35 INFO - Return code: 0 19:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:35 INFO - https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:51:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:51:36 INFO - Downloaded 10713410 bytes. 19:51:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:51:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:51:36 INFO - Return code: 0 19:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:36 INFO - https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:51:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:51:38 INFO - Downloaded 56640954 bytes. 19:51:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:38 INFO - mkdir: /builds/slave/test-pgo/properties 19:51:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:51:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:51:38 INFO - Contents: 19:51:38 INFO - build_url:https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:38 INFO - Running post-action listener: _resource_record_post_action 19:51:38 INFO - Running post-action listener: set_extra_try_arguments 19:51:38 INFO - ##### 19:51:38 INFO - ##### Running populate-webroot step. 19:51:38 INFO - ##### 19:51:38 INFO - Running pre-action listener: _resource_record_pre_action 19:51:38 INFO - Running main action method: populate_webroot 19:51:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:51:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:51:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:51:38 INFO - '--tppagecycles', 19:51:38 INFO - '7'], 19:51:38 INFO - 'tests': ['tsvgm']}}, 19:51:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:51:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:51:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:51:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:51:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:51:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:51:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:38 INFO - 'talos_options': ['--e10s'], 19:51:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:38 INFO - 'tests': ['damp', 'tps']}, 19:51:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:38 INFO - 'talos_options': ['--e10s'], 19:51:38 INFO - 'tests': ['damp', 'tps']}, 19:51:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:51:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:38 INFO - 'other': {'tests': ['a11yr', 19:51:38 INFO - 'ts_paint', 19:51:38 INFO - 'tpaint', 19:51:38 INFO - 'sessionrestore', 19:51:38 INFO - 'sessionrestore_no_auto_restore']}, 19:51:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:51:38 INFO - 'tests': ['a11yr', 19:51:38 INFO - 'ts_paint', 19:51:38 INFO - 'tpaint', 19:51:38 INFO - 'sessionrestore', 19:51:38 INFO - 'sessionrestore_no_auto_restore']}, 19:51:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:51:38 INFO - 'tests': ['a11yr', 19:51:38 INFO - 'ts_paint', 19:51:38 INFO - 'tpaint', 19:51:38 INFO - 'sessionrestore', 19:51:38 INFO - 'sessionrestore_no_auto_restore']}, 19:51:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:51:38 INFO - 'tests': ['a11yr', 19:51:38 INFO - 'ts_paint', 19:51:38 INFO - 'tpaint', 19:51:38 INFO - 'sessionrestore', 19:51:38 INFO - 'sessionrestore_no_auto_restore']}, 19:51:38 INFO - 'other_l64': {'tests': ['a11yr', 19:51:38 INFO - 'ts_paint', 19:51:38 INFO - 'tpaint', 19:51:38 INFO - 'sessionrestore', 19:51:38 INFO - 'sessionrestore_no_auto_restore']}, 19:51:38 INFO - 'other_nol64': {'tests': ['a11yr', 19:51:38 INFO - 'ts_paint', 19:51:38 INFO - 'tpaint', 19:51:38 INFO - 'sessionrestore', 19:51:38 INFO - 'sessionrestore_no_auto_restore']}, 19:51:38 INFO - 'svgr': {'tests': ['tsvgx', 19:51:38 INFO - 'tsvgr_opacity', 19:51:38 INFO - 'tart', 19:51:38 INFO - 'tscrollx', 19:51:38 INFO - 'cart']}, 19:51:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:51:38 INFO - 'tests': ['tsvgx', 19:51:38 INFO - 'tsvgr_opacity', 19:51:38 INFO - 'tart', 19:51:38 INFO - 'tscrollx', 19:51:38 INFO - 'cart']}, 19:51:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:38 INFO - 'tests': ['tp5o']}, 19:51:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:38 INFO - 'talos_options': ['--e10s'], 19:51:38 INFO - 'tests': ['tp5o']}, 19:51:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:38 INFO - 'talos_options': ['--xperf_path', 19:51:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:38 INFO - 'tests': ['tp5n']}, 19:51:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:38 INFO - 'talos_options': ['--e10s', 19:51:38 INFO - '--xperf_path', 19:51:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:38 INFO - 'tests': ['tp5n']}}, 19:51:38 INFO - 'talos.zip': {'path': '', 19:51:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:51:38 INFO - Running post-action listener: _resource_record_post_action 19:51:38 INFO - ##### 19:51:38 INFO - ##### Running create-virtualenv step. 19:51:38 INFO - ##### 19:51:38 INFO - Running pre-action listener: _resource_record_pre_action 19:51:38 INFO - Running main action method: create_virtualenv 19:51:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:51:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:51:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:51:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:38 INFO - Using real prefix '/usr' 19:51:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:51:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:41 INFO - Installing pip.................done. 19:51:41 INFO - Return code: 0 19:51:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5503a8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c238c0>, '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 0x1c247c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24c50>, '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': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:51:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:51:41 INFO - Using env: {'DISPLAY': ':0', 19:51:41 INFO - 'HOME': '/home/cltbld', 19:51:41 INFO - 'LANG': 'en_US.UTF-8', 19:51:41 INFO - 'LANGUAGE': 'en_US:en', 19:51:41 INFO - 'LOGNAME': 'cltbld', 19:51:41 INFO - 'MAIL': '/var/mail/cltbld', 19:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:41 INFO - 'MOZ_NO_REMOTE': '1', 19:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:41 INFO - 'NO_EM_RESTART': '1', 19:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:41 INFO - 'SHELL': '/bin/bash', 19:51:41 INFO - 'SHLVL': '1', 19:51:41 INFO - 'TERM': 'linux', 19:51:41 INFO - 'TMOUT': '86400', 19:51:41 INFO - 'USER': 'cltbld', 19:51:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 19:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:41 INFO - '_': '/tools/buildbot/bin/python'} 19:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:51:41 INFO - Cleaning up... 19:51:41 INFO - Return code: 0 19:51:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5503a8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c238c0>, '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 0x1c247c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24c50>, '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': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:51:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:51:41 INFO - Using env: {'DISPLAY': ':0', 19:51:41 INFO - 'HOME': '/home/cltbld', 19:51:41 INFO - 'LANG': 'en_US.UTF-8', 19:51:41 INFO - 'LANGUAGE': 'en_US:en', 19:51:41 INFO - 'LOGNAME': 'cltbld', 19:51:41 INFO - 'MAIL': '/var/mail/cltbld', 19:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:41 INFO - 'MOZ_NO_REMOTE': '1', 19:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:41 INFO - 'NO_EM_RESTART': '1', 19:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:41 INFO - 'SHELL': '/bin/bash', 19:51:41 INFO - 'SHLVL': '1', 19:51:41 INFO - 'TERM': 'linux', 19:51:41 INFO - 'TMOUT': '86400', 19:51:41 INFO - 'USER': 'cltbld', 19:51:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 19:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:41 INFO - '_': '/tools/buildbot/bin/python'} 19:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:41 INFO - Downloading/unpacking psutil>=0.7.1 19:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:43 INFO - Installing collected packages: psutil 19:51:43 INFO - Running setup.py install for psutil 19:51:43 INFO - building 'psutil._psutil_linux' extension 19:51:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:51:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:51:43 INFO - building 'psutil._psutil_posix' extension 19:51:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:51:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:51:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:44 INFO - Successfully installed psutil 19:51:44 INFO - Cleaning up... 19:51:44 INFO - Return code: 0 19:51:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5503a8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c238c0>, '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 0x1c247c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24c50>, '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': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:51:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:51:44 INFO - Using env: {'DISPLAY': ':0', 19:51:44 INFO - 'HOME': '/home/cltbld', 19:51:44 INFO - 'LANG': 'en_US.UTF-8', 19:51:44 INFO - 'LANGUAGE': 'en_US:en', 19:51:44 INFO - 'LOGNAME': 'cltbld', 19:51:44 INFO - 'MAIL': '/var/mail/cltbld', 19:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:44 INFO - 'MOZ_NO_REMOTE': '1', 19:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:44 INFO - 'NO_EM_RESTART': '1', 19:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:44 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:44 INFO - 'SHELL': '/bin/bash', 19:51:44 INFO - 'SHLVL': '1', 19:51:44 INFO - 'TERM': 'linux', 19:51:44 INFO - 'TMOUT': '86400', 19:51:44 INFO - 'USER': 'cltbld', 19:51:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 19:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:44 INFO - '_': '/tools/buildbot/bin/python'} 19:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:51:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:51:46 INFO - Installing collected packages: mozsystemmonitor 19:51:46 INFO - Running setup.py install for mozsystemmonitor 19:51:46 INFO - Successfully installed mozsystemmonitor 19:51:46 INFO - Cleaning up... 19:51:46 INFO - Return code: 0 19:51:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5503a8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c238c0>, '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 0x1c247c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24c50>, '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': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:51:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:51:46 INFO - Using env: {'DISPLAY': ':0', 19:51:46 INFO - 'HOME': '/home/cltbld', 19:51:46 INFO - 'LANG': 'en_US.UTF-8', 19:51:46 INFO - 'LANGUAGE': 'en_US:en', 19:51:46 INFO - 'LOGNAME': 'cltbld', 19:51:46 INFO - 'MAIL': '/var/mail/cltbld', 19:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:46 INFO - 'MOZ_NO_REMOTE': '1', 19:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:46 INFO - 'NO_EM_RESTART': '1', 19:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:46 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:46 INFO - 'SHELL': '/bin/bash', 19:51:46 INFO - 'SHLVL': '1', 19:51:46 INFO - 'TERM': 'linux', 19:51:46 INFO - 'TMOUT': '86400', 19:51:46 INFO - 'USER': 'cltbld', 19:51:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 19:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:46 INFO - '_': '/tools/buildbot/bin/python'} 19:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:46 INFO - Downloading/unpacking blobuploader==1.2.4 19:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:48 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:51:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:49 INFO - Downloading docopt-0.6.1.tar.gz 19:51:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:49 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:49 INFO - Running setup.py install for blobuploader 19:51:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:51:49 INFO - Running setup.py install for requests 19:51:49 INFO - Running setup.py install for docopt 19:51:49 INFO - Successfully installed blobuploader requests docopt 19:51:49 INFO - Cleaning up... 19:51:49 INFO - Return code: 0 19:51:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5503a8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c238c0>, '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 0x1c247c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24c50>, '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': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:51:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:51:49 INFO - Using env: {'DISPLAY': ':0', 19:51:49 INFO - 'HOME': '/home/cltbld', 19:51:49 INFO - 'LANG': 'en_US.UTF-8', 19:51:49 INFO - 'LANGUAGE': 'en_US:en', 19:51:49 INFO - 'LOGNAME': 'cltbld', 19:51:49 INFO - 'MAIL': '/var/mail/cltbld', 19:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:49 INFO - 'MOZ_NO_REMOTE': '1', 19:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:49 INFO - 'NO_EM_RESTART': '1', 19:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:49 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:49 INFO - 'SHELL': '/bin/bash', 19:51:49 INFO - 'SHLVL': '1', 19:51:49 INFO - 'TERM': 'linux', 19:51:49 INFO - 'TMOUT': '86400', 19:51:49 INFO - 'USER': 'cltbld', 19:51:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 19:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:49 INFO - '_': '/tools/buildbot/bin/python'} 19:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:50 INFO - Running setup.py (path:/tmp/pip-rt9FPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:50 INFO - Running setup.py (path:/tmp/pip-6OxBPJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:50 INFO - Running setup.py (path:/tmp/pip-Q2lXI3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:50 INFO - Running setup.py (path:/tmp/pip-eUXLo6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:50 INFO - Running setup.py (path:/tmp/pip-xt5RoI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:50 INFO - Running setup.py (path:/tmp/pip-2lVkZT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:50 INFO - Running setup.py (path:/tmp/pip-XlC3vw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:50 INFO - Running setup.py (path:/tmp/pip-yw_oAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:50 INFO - Running setup.py (path:/tmp/pip-Crymoq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:50 INFO - Running setup.py (path:/tmp/pip-r1Dp5W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:50 INFO - Running setup.py (path:/tmp/pip-kehoBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:50 INFO - Running setup.py (path:/tmp/pip-agevBK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:50 INFO - Running setup.py (path:/tmp/pip-lJP0_M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:50 INFO - Running setup.py (path:/tmp/pip-VTUKLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:51 INFO - Running setup.py (path:/tmp/pip-CnQJfF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:51 INFO - Running setup.py (path:/tmp/pip-cjT3G9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:51 INFO - Running setup.py (path:/tmp/pip-hC13Bs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:51 INFO - Running setup.py install for manifestparser 19:51:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:51:51 INFO - Running setup.py install for mozcrash 19:51:51 INFO - Running setup.py install for mozdebug 19:51:51 INFO - Running setup.py install for mozdevice 19:51:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:51:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:51:51 INFO - Running setup.py install for mozfile 19:51:51 INFO - Running setup.py install for mozhttpd 19:51:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:51:51 INFO - Running setup.py install for mozinfo 19:51:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:51:51 INFO - Running setup.py install for mozInstall 19:51:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Running setup.py install for mozleak 19:51:52 INFO - Running setup.py install for mozlog 19:51:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Running setup.py install for moznetwork 19:51:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Running setup.py install for mozprocess 19:51:52 INFO - Running setup.py install for mozprofile 19:51:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Running setup.py install for mozrunner 19:51:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:51:52 INFO - Running setup.py install for mozscreenshot 19:51:52 INFO - Running setup.py install for moztest 19:51:52 INFO - Running setup.py install for mozversion 19:51:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:51:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:53 INFO - Cleaning up... 19:51:53 INFO - Return code: 0 19:51:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5503a8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c238c0>, '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 0x1c247c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24c50>, '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': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:51:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:51:53 INFO - Using env: {'DISPLAY': ':0', 19:51:53 INFO - 'HOME': '/home/cltbld', 19:51:53 INFO - 'LANG': 'en_US.UTF-8', 19:51:53 INFO - 'LANGUAGE': 'en_US:en', 19:51:53 INFO - 'LOGNAME': 'cltbld', 19:51:53 INFO - 'MAIL': '/var/mail/cltbld', 19:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:53 INFO - 'MOZ_NO_REMOTE': '1', 19:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:53 INFO - 'NO_EM_RESTART': '1', 19:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:53 INFO - 'SHELL': '/bin/bash', 19:51:53 INFO - 'SHLVL': '1', 19:51:53 INFO - 'TERM': 'linux', 19:51:53 INFO - 'TMOUT': '86400', 19:51:53 INFO - 'USER': 'cltbld', 19:51:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 19:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:53 INFO - '_': '/tools/buildbot/bin/python'} 19:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:53 INFO - Running setup.py (path:/tmp/pip-f4rPfr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:53 INFO - Running setup.py (path:/tmp/pip-2Cu0QZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:53 INFO - Running setup.py (path:/tmp/pip-oDkfxn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:53 INFO - Running setup.py (path:/tmp/pip-2DGDFX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:53 INFO - Running setup.py (path:/tmp/pip-SHJjdC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:53 INFO - Running setup.py (path:/tmp/pip-kaLuKk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:53 INFO - Running setup.py (path:/tmp/pip-GW19CH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:53 INFO - Running setup.py (path:/tmp/pip-qorKl1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:53 INFO - Running setup.py (path:/tmp/pip-RbJjMr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:53 INFO - Running setup.py (path:/tmp/pip-9s0K7T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:53 INFO - Running setup.py (path:/tmp/pip-BrYoaS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:54 INFO - Running setup.py (path:/tmp/pip-e0U8_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:54 INFO - Running setup.py (path:/tmp/pip-SgKtZL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:54 INFO - Running setup.py (path:/tmp/pip-lVmuiO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:54 INFO - Running setup.py (path:/tmp/pip-y5h2Fe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:54 INFO - Running setup.py (path:/tmp/pip-o2LhUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:54 INFO - Running setup.py (path:/tmp/pip-TVmTV6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:51:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:56 INFO - Downloading blessings-1.6.tar.gz 19:51:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:56 INFO - Installing collected packages: blessings 19:51:56 INFO - Running setup.py install for blessings 19:51:56 INFO - Successfully installed blessings 19:51:56 INFO - Cleaning up... 19:51:56 INFO - Return code: 0 19:51:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:51:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:51:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:51:56 INFO - Reading from file tmpfile_stdout 19:51:56 INFO - Current package versions: 19:51:56 INFO - argparse == 1.2.1 19:51:56 INFO - blessings == 1.6 19:51:56 INFO - blobuploader == 1.2.4 19:51:56 INFO - docopt == 0.6.1 19:51:56 INFO - manifestparser == 1.1 19:51:56 INFO - mozInstall == 1.12 19:51:56 INFO - mozcrash == 0.16 19:51:56 INFO - mozdebug == 0.1 19:51:56 INFO - mozdevice == 0.48 19:51:56 INFO - mozfile == 1.2 19:51:56 INFO - mozhttpd == 0.7 19:51:56 INFO - mozinfo == 0.9 19:51:56 INFO - mozleak == 0.1 19:51:56 INFO - mozlog == 3.1 19:51:56 INFO - moznetwork == 0.27 19:51:56 INFO - mozprocess == 0.22 19:51:56 INFO - mozprofile == 0.28 19:51:56 INFO - mozrunner == 6.11 19:51:56 INFO - mozscreenshot == 0.1 19:51:56 INFO - mozsystemmonitor == 0.0 19:51:56 INFO - moztest == 0.7 19:51:56 INFO - mozversion == 1.4 19:51:56 INFO - psutil == 3.1.1 19:51:56 INFO - requests == 1.2.3 19:51:56 INFO - wsgiref == 0.1.2 19:51:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5503a8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c238c0>, '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 0x1c247c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24c50>, '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': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:51:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:51:56 INFO - Using env: {'DISPLAY': ':0', 19:51:56 INFO - 'HOME': '/home/cltbld', 19:51:56 INFO - 'LANG': 'en_US.UTF-8', 19:51:56 INFO - 'LANGUAGE': 'en_US:en', 19:51:56 INFO - 'LOGNAME': 'cltbld', 19:51:56 INFO - 'MAIL': '/var/mail/cltbld', 19:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:56 INFO - 'MOZ_NO_REMOTE': '1', 19:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:56 INFO - 'NO_EM_RESTART': '1', 19:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:56 INFO - 'SHELL': '/bin/bash', 19:51:56 INFO - 'SHLVL': '1', 19:51:56 INFO - 'TERM': 'linux', 19:51:56 INFO - 'TMOUT': '86400', 19:51:56 INFO - 'USER': 'cltbld', 19:51:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 19:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:56 INFO - '_': '/tools/buildbot/bin/python'} 19:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:51:56 INFO - Cleaning up... 19:51:56 INFO - Return code: 0 19:51:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5503a8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c238c0>, '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 0x1c247c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24c50>, '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': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:51:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:51:56 INFO - Using env: {'DISPLAY': ':0', 19:51:56 INFO - 'HOME': '/home/cltbld', 19:51:56 INFO - 'LANG': 'en_US.UTF-8', 19:51:56 INFO - 'LANGUAGE': 'en_US:en', 19:51:56 INFO - 'LOGNAME': 'cltbld', 19:51:56 INFO - 'MAIL': '/var/mail/cltbld', 19:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:56 INFO - 'MOZ_NO_REMOTE': '1', 19:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:56 INFO - 'NO_EM_RESTART': '1', 19:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:56 INFO - 'SHELL': '/bin/bash', 19:51:56 INFO - 'SHLVL': '1', 19:51:56 INFO - 'TERM': 'linux', 19:51:56 INFO - 'TMOUT': '86400', 19:51:56 INFO - 'USER': 'cltbld', 19:51:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 19:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:56 INFO - '_': '/tools/buildbot/bin/python'} 19:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:57 INFO - Downloading/unpacking jsonschema 19:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:51:59 INFO - Downloading/unpacking functools32 (from jsonschema) 19:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:59 INFO - Downloading functools32-3.2.3-2.tar.gz 19:51:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:51:59 INFO - warning: no files found matching '*.txt' 19:51:59 INFO - no previously-included directories found matching 'build' 19:51:59 INFO - no previously-included directories found matching 'dist' 19:51:59 INFO - no previously-included directories found matching '.git*' 19:51:59 INFO - Installing collected packages: jsonschema, functools32 19:51:59 INFO - Running setup.py install for functools32 19:51:59 INFO - warning: no files found matching '*.txt' 19:51:59 INFO - no previously-included directories found matching 'build' 19:51:59 INFO - no previously-included directories found matching 'dist' 19:51:59 INFO - no previously-included directories found matching '.git*' 19:51:59 INFO - Successfully installed jsonschema functools32 19:51:59 INFO - Cleaning up... 19:51:59 INFO - Return code: 0 19:51:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5503a8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c238c0>, '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 0x1c247c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24c50>, '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': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:51:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:51:59 INFO - Using env: {'DISPLAY': ':0', 19:51:59 INFO - 'HOME': '/home/cltbld', 19:51:59 INFO - 'LANG': 'en_US.UTF-8', 19:51:59 INFO - 'LANGUAGE': 'en_US:en', 19:51:59 INFO - 'LOGNAME': 'cltbld', 19:51:59 INFO - 'MAIL': '/var/mail/cltbld', 19:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:59 INFO - 'MOZ_NO_REMOTE': '1', 19:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:59 INFO - 'NO_EM_RESTART': '1', 19:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:59 INFO - 'SHELL': '/bin/bash', 19:51:59 INFO - 'SHLVL': '1', 19:51:59 INFO - 'TERM': 'linux', 19:51:59 INFO - 'TMOUT': '86400', 19:51:59 INFO - 'USER': 'cltbld', 19:51:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 19:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:59 INFO - '_': '/tools/buildbot/bin/python'} 19:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:59 INFO - Downloading/unpacking flake8 19:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:52:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:52:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:52:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:52:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:52:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:52:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:52:02 INFO - no previously-included directories found matching 'docs/_build' 19:52:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:52:02 INFO - Running setup.py install for pep8 19:52:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:52:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:52:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:52:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:52:02 INFO - no previously-included directories found matching 'docs/_build' 19:52:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:52:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:52:02 INFO - Cleaning up... 19:52:02 INFO - Return code: 0 19:52:02 INFO - Running post-action listener: _resource_record_post_action 19:52:02 INFO - Running post-action listener: _start_resource_monitoring 19:52:02 INFO - Starting resource monitoring. 19:52:02 INFO - ##### 19:52:02 INFO - ##### Running install step. 19:52:02 INFO - ##### 19:52:02 INFO - Running pre-action listener: _resource_record_pre_action 19:52:02 INFO - Running main action method: install 19:52:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:52:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:52:02 INFO - Reading from file tmpfile_stdout 19:52:02 INFO - Detecting whether we're running mozinstall >=1.0... 19:52:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:52:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:52:02 INFO - Reading from file tmpfile_stdout 19:52:02 INFO - Output received: 19:52:02 INFO - Usage: mozinstall [options] installer 19:52:02 INFO - Options: 19:52:02 INFO - -h, --help show this help message and exit 19:52:02 INFO - -d DEST, --destination=DEST 19:52:02 INFO - Directory to install application into. [default: 19:52:02 INFO - "/builds/slave/test-pgo"] 19:52:02 INFO - --app=APP Application being installed. [default: firefox] 19:52:02 INFO - mkdir: /builds/slave/test-pgo/build/application 19:52:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:52:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:52:19 INFO - Reading from file tmpfile_stdout 19:52:19 INFO - Output received: 19:52:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:52:19 INFO - Running post-action listener: _resource_record_post_action 19:52:19 INFO - ##### 19:52:19 INFO - ##### Running run-tests step. 19:52:19 INFO - ##### 19:52:19 INFO - Running pre-action listener: _resource_record_pre_action 19:52:19 INFO - Running main action method: run_tests 19:52:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:52:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:52:19 INFO - Python 2.7.3 19:52:19 INFO - Return code: 0 19:52:19 INFO - grabbing minidump binary from tooltool 19:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:52:19 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 0x1c238c0>, '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 0x1c247c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:52:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:52:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:52:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:52:19 INFO - Return code: 0 19:52:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:52:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:52:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:52:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:52:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:52:20 INFO - Return code: 0 19:52:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 19:52:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:52:20 INFO - Using env: {'DISPLAY': ':0', 19:52:20 INFO - 'HOME': '/home/cltbld', 19:52:20 INFO - 'LANG': 'en_US.UTF-8', 19:52:20 INFO - 'LANGUAGE': 'en_US:en', 19:52:20 INFO - 'LOGNAME': 'cltbld', 19:52:20 INFO - 'MAIL': '/var/mail/cltbld', 19:52:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:20 INFO - 'MOZ_NO_REMOTE': '1', 19:52:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:20 INFO - 'NO_EM_RESTART': '1', 19:52:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:52:20 INFO - 'PWD': '/builds/slave/test-pgo', 19:52:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:52:20 INFO - 'SHELL': '/bin/bash', 19:52:20 INFO - 'SHLVL': '1', 19:52:20 INFO - 'TERM': 'linux', 19:52:20 INFO - 'TMOUT': '86400', 19:52:20 INFO - 'USER': 'cltbld', 19:52:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830', 19:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:20 INFO - '_': '/tools/buildbot/bin/python'} 19:52:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:52:20 INFO - mozversion application_buildid: 20160226173019 19:52:20 INFO - mozversion application_changeset: f3b3ade07154fe0bee9ecd02e15bbfe94ea74754 19:52:20 INFO - mozversion application_display_name: Nightly 19:52:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:52:20 INFO - mozversion application_name: Firefox 19:52:20 INFO - mozversion application_remotingname: firefox 19:52:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:52:20 INFO - mozversion application_vendor: Mozilla 19:52:20 INFO - mozversion application_version: 47.0a1 19:52:20 INFO - mozversion platform_buildid: 20160226173019 19:52:20 INFO - mozversion platform_changeset: f3b3ade07154fe0bee9ecd02e15bbfe94ea74754 19:52:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:52:20 INFO - mozversion platform_version: 47.0a1 19:52:20 INFO - using testdate: 1456545140 19:52:20 INFO - actual date: 1456545140 19:52:20 INFO - starting webserver on 'localhost:34009' 19:52:20 INFO - SUITE-START | Running 2 tests 19:52:20 INFO - TEST-START | dromaeo_css 19:52:20 INFO - operating with platform_type : linux_ 19:52:20 INFO - Initialising browser for dromaeo_css test... 19:52:20 INFO - TEST-INFO | started process 9212 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD2yafU/profile http://localhost:34009/getInfo.html) 19:52:24 INFO - PROCESS | 9212 | 19:52:24 INFO - PROCESS | 9212 | (process:9296): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:52:25 INFO - PROCESS | 9212 | __metrics Screen width/height:1600/1200 19:52:25 INFO - PROCESS | 9212 | colorDepth:24 19:52:25 INFO - PROCESS | 9212 | Browser inner width/height: 1024/697 19:52:25 INFO - PROCESS | 9212 | __metrics 19:52:25 ERROR - PROCESS | 9212 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:52:25 INFO - PROCESS | 9212 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:52:25 INFO - PROCESS | 9212 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:52:25 INFO - PROCESS | 9212 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:52:25 INFO - PROCESS | 9212 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:52:25 INFO - PROCESS | 9212 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:52:25 INFO - PROCESS | 9212 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:52:25 INFO - PROCESS | 9212 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:52:25 INFO - PROCESS | 9212 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:52:25 INFO - PROCESS | 9212 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:52:26 INFO - TEST-INFO | 9212: exit 0 19:52:26 INFO - Browser initialized. 19:52:26 INFO - Running cycle 1/1 for dromaeo_css test... 19:52:26 INFO - TEST-INFO | started process 9347 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD2yafU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:27 INFO - PROCESS | 9347 | 19:52:27 INFO - PROCESS | 9347 | (process:9406): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:52:38 INFO - PROCESS | 9347 | RSS: Main: 158543872 19:52:38 INFO - PROCESS | 9347 | 19:53:28 INFO - PROCESS | 9347 | 1456545208022 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:55:35 INFO - PROCESS | 9347 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34009/tests/dromaeo/cssquery-ext.html) 19:55:36 INFO - PROCESS | 9347 | RSS: Main: 164581376 19:55:36 INFO - PROCESS | 9347 | 19:58:38 INFO - PROCESS | 9347 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-ext.html (next: http://localhost:34009/tests/dromaeo/cssquery-jquery.html) 19:58:39 INFO - PROCESS | 9347 | RSS: Main: 161636352 19:58:39 INFO - PROCESS | 9347 | 20:01:41 INFO - PROCESS | 9347 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34009/tests/dromaeo/cssquery-mootools.html) 20:01:41 INFO - PROCESS | 9347 | RSS: Main: 162729984 20:01:41 INFO - PROCESS | 9347 | 20:04:43 INFO - PROCESS | 9347 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34009/tests/dromaeo/cssquery-prototype.html) 20:04:44 INFO - PROCESS | 9347 | RSS: Main: 161697792 20:04:44 INFO - PROCESS | 9347 | 20:07:46 INFO - PROCESS | 9347 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34009/tests/dromaeo/cssquery-yui.html) 20:07:47 INFO - PROCESS | 9347 | RSS: Main: 161226752 20:07:47 INFO - PROCESS | 9347 | 20:10:49 INFO - PROCESS | 9347 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-yui.html (next: http://localhost:34009/tests/dromaeo/cssquery-dojo.html) 20:10:49 INFO - PROCESS | 9347 | RSS: Main: 165584896 20:10:49 INFO - PROCESS | 9347 | 20:10:49 INFO - PROCESS | 9347 | __start_tp_report 20:10:49 INFO - PROCESS | 9347 | _x_x_mozilla_page_load 20:10:49 INFO - PROCESS | 9347 | _x_x_mozilla_page_load_details 20:10:49 INFO - PROCESS | 9347 | |i|pagename|runs| 20:10:49 INFO - PROCESS | 9347 | |0;dojo.html;3201.7758756887015;3202.4395730747115;3251.170951407391;3252.7397808175347;3259.2829577492944;5162.922556161656;5169.534741873231;5209.296744939432;5218.373795144583;5218.843434696955;5169.844904652867;5172.586193104552;5182.559482443997;5200.557952574026;5311.389190243123;4762.809487620491;4773.641976851742;4834.468208497063;4839.637027222955;4883.340748998875;193.62398444776554;4797.136515427222;4816.422029356482;4852.684575502599;4877.634177436688;4686.367340409052;4738.8341408050555;4804.879878003043;4805.927911081337;4836.298736683161;4792.95207047932;4807.351007613962;4820.156472617313;4822.300766388854;4860.343853579757;4702.5297470253045;4756.143894099096;4783.162946484351;4826.734529600871;4857.392825896763;5084;5099.082165210298;5107.565856902131;5121.743912804345;5171.327727395452;5580.581456390787;5668.68822214778;5671.6597004179885;5672.34768001681;5737.540996720252;5574.386817450078;5644.463775941279;5692;5700.37295897451;5703;5325.840224793263;5333.626646134772;5347.46525347466;5365.651232669864;5372.946270537283;5778.8266352009505;5780.971095144498;5792.304923409218;5795.913061304083;5800.100984347433;5464.644798088111;5578.079616863172;5628.690422026746;5639.492445679908;5653.321601407857;5576.191452239484;5600.383957764642;5614.101743721067;5614.438556144353;5621.943780562142;5543.113101903676;5564;5564.387917329091;5567.053600887859;5571.526420254243;5535.972320138373;5585;5631.915521267184;5650.039493286069;5679.971600141973;4306.978465107717;4309.900975251291;4311.223979683625;4313.956860431355;4337.674674399433;3809.104860357814;3891.591382904754;3892.727509074338;3904.4533765272886;3941.92116157681;5303.390110137384;5314.840554783363;5364.8122315718765;5366.302380690485;5396.730163491889;5627.21219029328;5644.153376993402;5659.264295641623;5662.971685141548;5667.09326507765;5296.09966305729;5334.546563542142;5357.7589008494715;5392.568594512508;5397.514223719884;4805.087033463631;4805.903881922342;4807.61539076873;4813.229883218738;4850.975745121323;5963.135345374896;5993.400659934059;6016.488598469179;6026.306974697965;6033.396660333931;5527.5577953762795;5617.719114044363;5664.037113690682;5674.659520428788;5683.971580142238;5922.822315330547;5959.67221802805;5966.373530779206;5978.491828194652;6000.009998350223;5528.364238112668;5536.446355364431;5538.47384498472;5568.276124103841;5592.049351610155;5585.413531579125;5645.68948707825;5646.209530665792;5658.066419040812;5710.2291190690385;5476.534494567847;5523.502884740393;5534.335879694301;5542.168674698827;5555.527780138734;5495.972520137374;5511.53151982086;5518.613697041169;5528.226048353315;5576.1356989666665;5310.946890531045;5329.866753331198;5400.162974738922;5460;5465.863353416196;5454.727263636723;5480.232767412645;5481.177823326533;5517.393086760533;5519.586031047607;5350.411454740053;5364.946350536601;5380.973095134499;5397.487238712316;5421.295231619864 20:10:49 INFO - PROCESS | 9347 | |1;ext.html;520.5263210478465;525.0260766278551;571.0007486897929;591.9911201331978;595.1994567306971;36036.45945310819;36079.458808117866;36287.274254514894;36635.45046824293;36733;40042;40371.394429083586;40379.394309085386;40415.19169616606;40507.79746101273;8462.703805366798;8669.869951950726;8690.348223883235;8701.259748050416;8717.607707653171;8488.575571221445;8598.140185981383;8598.742037738877;8617.482951022926;8653.913460865406;8754.912450875474;8787.912120878806;8794.736157915273;8795.208431241186;8822.955885220565;8755.124487551226;8802.911970880337;8803.955980220122;8813.779655508599;8835;8777.42946708462;8887.24458421035;8899.154580314924;8913.732588022369;8918.152775486318;40208.19583608341;40267.597324026676;40679.7966010171;40682;40742.796286018674;3166.300105014968;3261.2010057535817;3390.5253264542985;3396.6093899201414;3478.826058697055;27000.864995675092;27043.1887043389;27386.589201161998;27660.723392766016;27679.723202768117;3695.4456831475227;3731.365667836474;3740.588535261119;3867.323218436762;3907.4920260366252;270141;270297;271628;272099;273040;41092.58907410948;61015;61291.38708612857;61435.6928215365;61514.69242653847;39908.40137397941;40057.1988560233;40109.59890401117;40192.39711404331;40265.79867100646;13599.252041137635;13838.100523465942;13858.792118118236;13862.584122476343;13889.930550347184;10768.084712799344;10778.676639700821;10816.080633146114;10837;10961.232713709964;13673.453061877612;13766.862331376758;14255.429782808571;14262.144271343544;14310.928445357707;5774.82675519735;5803.448672376117;5809.941900581025;5843.5909486336395;5884.735186916599;943.5188054092463;993.7664648807524;999.2405771613626;1022.6676330192569;1072.9195310351754;28866.27834304159;29092.854535727187;29212.415751684846;29265.85367073151;29338.706612934024;1044.7492601775518;1056.7780766039064;1074.188987314588;1110.0730889707024;1147.5926046253626;14830.555083347517;15122.773158402633;15365.769513457308;16393.34426622922;16467.505974820775;403192;407683;410141;411398;414615;55640.72179639076;55772.72113639406;56340.43659563434;56437.71781141068;56465.7176714122;1294.786360250567;1333.693250552359;1335.9599212023654;1340.4102195034154;1345.118947089658;29180.70819291865;30538.236544086576;30620;30727.539086913268;30913.785328093556;45296.773516132205;45503.772481137385;45854.54145458503;45879.31181032354;45924.770376147906;288983;290802;292123;292258;292602;31290.530642039932;31380.529292061095;31779;31856.8407157972;32019.67980320167;41782;42157.78921105375;42849.571504284555;42881.14237715166;43134.56865431306;35373.82313088418;35712.10719732028;35750.642493574735;36089;36401.817990909876;34198.31603367869;34807.129821753646;35212.29575408529;35226.29547409089;35386;36228.27543449169;36443.817780910926;39169.41245881257;39760;40039.39940900831;31023;32833;33763.493547596314;33798.66201337955;33859.3228135431;25000.499989999735;25329.240122796346;25586.61620075663;25597.488050239263;25863 20:10:49 INFO - PROCESS | 9347 | |2;jquery.html;350.8053030568034;356.203884318548;358.3442300589921;359.1989862606388;359.8344761409752;16991.490255292345;17247.91376043118;17433.389831355904;17601.91199044003;17649.20578573964;13428.530001449952;14200.289985500709;16578.75131873023;16700.66598668029;16706;5291.497307755757;5313.814016509423;5424.83725488236;5436.972815135919;5496.80761173359;5325.707086110262;5369.087255166631;5383.703896285702;5384.380796208447;5426.728663566825;5277.525022747952;5293.788248470057;5319.494648008433;5336.9733151334385;5343.599230057742;5219.034478621448;5219.269302297681;5323.334583177103;5344.118220493614;5369.275147855068;4682.344471773954;4755.096531658974;4777.784999674988;4783.3064205690325;4792;20799.68800467994;21245.46886327854;21317.893410533004;21418.03618837156;21565.78434215669;2136.2202795979356;2210.458437682762;2390.497995420964;2568.203856804378;2727.7861351698502;13170.34148292591;13232.338383080807;13401.46394144233;13577.11748736329;13794;1886.1323791055993;1931.5943651833131;1943.640426521084;1950.3953774330002;1960.44127423685;53965;60483.39516604822;64233.3576664232;66390.3360966389;67929;10058;10189.796204076025;10421.895781042092;10447.268691191695;10586.4706764663;13628.386722597506;13638.795418068737;13692.65768355779;13727.519536816364;13758;7110.786676399716;7281.308275713799;7365.484416090822;7412.369948554326;7425.62871856405;7168.964155179295;7178.928210717931;7203.027591275216;7264.963675181591;7395.519291246052;4278.957210427856;4347.239233134189;4348.760818154969;4416.580424859633;4443.155800397914;1693.9237734301987;1706.1895599590096;1711.6918954588045;1719.5872990482444;1725.8446739793228;884.6372987075397;913.1325241020924;914.9935071421384;925.9259259259243;936.578539657157;16597.941751260943;16639.334426622798;17134.228959696844;17274.568135796704;17422.303107875796;903.6069309850236;913.1005959130251;919.1727445299284;974.3471873844542;1003.3528374198601;9956.80086398268;10050.246231532665;10115.595376185018;10123.59505619767;10133.645322413828;403290;406048;415570;418247;420273;61417.69291153516;72611.2738872615;74710.25289747033;75323;77424;1034.3018462537907;1046.0062940206833;1057.8730552333616;1069.9197560183018;1070.9303895246785;16195.919020404823;16257.61810246095;16302.429414970893;16532.338706452087;16830.074345911093;34694;35247;35464.82267588749;36063.819680901426;37011.62988370082;50330.748346258035;50967.490325096274;51281.43772277593;51693.22460163176;51797.48202517926;7758.301752842045;7795.298423141944;7869.567173805495;8037.678492860454;8280.83438331218;9019.098090190928;12087.697807554881;12585.43365548571;12738.235705857678;13060.608181754562;10577.9471102644;11035.503402347074;11122.666320010412;11368;11408;11100.500477478694;11104.5558177672;11121.666350009513;11140.33158010522;11332.943335283271;11258.831117533407;11443.485043173243;11469.31184128955;11578.536858525902;11622.244554104294;7981.161977992228;8018.599070046358;8139.10469848328;8140.470869393471;8460.407771455939;10907.509162087883;11394.94302528482;11477.82783258235;11556.826647600124;11575.42122893835 20:10:49 INFO - PROCESS | 9347 | |3;mootools.html;1477.6379786952195;1478.13529085485;1637.9099149546778;1676.4886709553582;1770.7166853303465;7471.962640186798;7588.58262795546;7724.227577242273;7729.149793522708;7732.420068494871;7611.238876112386;7674;7710.57591832449;7711.845763084735;7769.494982826112;2269.2511471214502;2301.056566807609;2301.309607117866;2301.8964146613444;2305.101010605865;2256.898439570223;2286.2569664858906;2291.8854057297067;2294.977050229493;2295.104909085458;2274.37454699958;2275.4425165834396;2286.039863257436;2311.6763653088497;2317.5017371265176;2273.1134857405623;2295.701558797354;2310.9422264443438;2320.6170981787986;2326.069572171128;2259.8418110732255;2260.8417410781253;2275.397019789757;2281.0761641535205;2282.1784157703214;7717.922820771777;7800.648970796327;7840.0591928968315;7846.097698764658;7866.606669666494;4609.562091601292;4706.552877476634;4717.905641887143;4732.195526760459;4734.384530011076;2951.513000354939;2970.5692674562283;3065.2796592800673;3094.8607312670983;3109.9689003110134;975.4781192062284;986.9062439068277;1003.0220534978411;1009.8362601441066;1028.228828378716;10584.576616935314;10614.946925265323;10673.1995100367;10691.625793097204;10769.084627806567;3924.489816323917;3961.088949541564;4043.8786836394956;4045.7370270932297;4072.6538244249573;8458.111898250596;8492.660293588311;8498.74503764888;8504.362172837062;8522.87215691765;4600.493945665974;4605.838795642137;4626.791794369262;4628.074385122989;4629.699069560468;3790.1472168761807;4127.876163715094;4203.495580530294;4217.915641687149;4225.3239481683395;3440.3807314683095;3451.171718787473;3465.4282043462545;3487.197944472735;3512.7189824813954;1010.5099026971913;1045.9215558833118;1047.402980301221;1055.2824079625927;1056.6671498477954;1301.3168086754529;1304.3934570424608;1304.8108024336607;1343.033016228314;1355.5120156743565;7244.673989670478;7297.489175757646;7426.480146389809;7457.7016919323705;7461.216572259943;454.33666846404617;459.62081282941705;460.75810199645457;465.4530926161746;467.35738359755334;5336.866578335573;5420.430854760272;5438.864028399322;5442.510174084351;5460.262864513319;8941.105889411007;9074;9453.905460945303;9468.289878259158;9479.194268487117;9139.177474027369;9154.038825923315;9242.86135707965;9309.860352094724;9323.766905827408;6819.5908245505425;6990.650467476606;7000.194977577644;7278.781636550912;7388.778336649909;7139.286071392819;7167.1757747859665;7210.315020073084;7213.927860721536;7268.382187513909;7880.527168369917;8211.809287653376;8218.671253150047;8268.2558569729;8356.832863342577;8453.873191902003;8493.702720404755;8545.700900468453;8580.785480363042;8589.269912057545;6087;6513.609183449008;6713.56361836479;6825.180978282439;6928.4803639726215;7475.700971961278;7507.624618769149;7512.173660897406;7543.962280188564;7565.4325925556905;6505.349465053457;6535.57518761279;6649.734010639714;6714.899276510759;6942.340477654615;6707.496937729592;6715.731370745116;6776.796696099125;6783.559068660521;6787.5588086774205;7081.964590177016;7138.785836424916;7149.857002860018;7158.319959603829;7221.891671625035;6321.209848768904;6328.7152078157515;6330.936690633035;6341.207349081365;6361.982082866719;6426.293107758236;6458.257300410513;6485.8702825944165;6509.674516274262;6524.641144737085 20:10:49 INFO - PROCESS | 9347 | |4;prototype.html;300.39020787800746;301.5612284126596;307.5264093296323;315.2497057004331;315.57082367979535;6024.638521688702;6124.632522048681;6176.227971503557;6215.285242197148;6224.284207316148;6099.1766111574925;6101.603395779282;6112.174856394386;6114.3579924108;6133;4463.33050042493;4556.681032327739;4580;4651.209294419939;4686.531346865312;4622.121796858586;4636.605888499482;4639.930401043987;4647.907041859161;4655;4558.61251793598;4568.931466028012;4593.242115051013;4612.746298953556;4613.492515823256;4600.746958917275;4600.792964316597;4610.170169369512;4616.28447590624;4616.7691615419435;3958.4853968984135;3978.900527486807;3979.243943650697;3981.9601803981877;3986.5614782374205;5941.346451890288;5948.702564871739;5950.642961422329;5953.345132035516;5956.285245770492;5214.270002199695;5310.70791106489;5319.069162896516;5330.600204984603;5341.973290133564;6504.5121615878525;6521.31526189748;6535.836604084889;6543.541952063358;6544.541882068257;4301.784910754481;4344.087741574273;4344.913101737948;4357.869263922055;4365.581186114526;6733.8653226935185;6825.283345248727;6830.487713421464;6847.657617119125;6877.828054298632;4452.243118669834;4475.14972155296;4479.641628669699;4479.888002799956;4484.865454036384;4343.109662519176;4474.977625111918;4500.774961251925;4514.909701806011;4524.5249248828395;5305.734713264322;5309.283246761715;5323.201519772065;5326.707031113326;5331.893362132736;6519.543631945813;6576.934230657728;6577.6053436793945;6591.934080659132;6593.505487088488;1579.0367875595878;1596.960075998086;1598.2408356031024;1599.09651047158;1600.2558810153334;1001.6444162322416;1015.0661391519819;1027.440045175381;1043.5773511727762;1047.5076713944434;6296.992481202986;6319.684015799192;6331.715072821734;6356.237251529754;6371.649559274284;6686.765963191265;6744.7976560703255;6781.152355955505;6790.117284752951;6806.591604503746;6274.121622972787;6293.937060629427;6295.905561416583;6438.645874476949;6458.644774537352;3649.3431182387426;3660.359437098497;3699.6855267302044;3705.5368078990127;3712.832922518493;7298.854022919512;7311.524750891175;7322.82834746438;7323.194448610649;7340.11918569775;6980.162380514371;6980.895286570705;6994.405475534637;7005.773989551808;7007.684654190573;7119.181294151239;7282.890756638654;7295.124585049828;7321.267873212742;7347.485676002735;6808.65956702153;6810.625415601991;6815.522913396015;6834.965825170842;6841.589504629738;6724.865502690017;6733.898991515033;6751.223609284995;6753.966230168818;6766.763163289262;7245.094363204599;7305.890411643936;7306.1963184048645;7322.926770732224;7323.597202153933;4330.718503297276;4421.602055814992;4422.3587579800105;4424.557544245549;4436.977815110904;6794.286599907136;6835.692393842389;6857.691403886737;6862.794116176523;6873.656317184021;6592.80221593353;6596.109525214035;6600.438962688226;6612.338766123542;6618.569792963442;6563.409293163638;6572.934270657423;6610.3720146586;6618.867622647616;6622.205335359788;6253.6560489173535;6458.773942912164;6499.967500162469;6515.902261466176;6519.1199188110895;6621.702023409054;6641.767538136142;6645.069690243273;6666.83332916681;6667.933320666925;6459.870802584016;6464.806055818333;6480.092787009917;6511.544191906521;6518.543701940818 20:10:49 INFO - PROCESS | 9347 | |5;yui.html;664.0935123556344;665.0523004718275;730.4302643937729;829.5934991853993;831.9875201871971;13063.869361306384;13261.270630115363;13276;13283.7343253135;13298.601041968745;12911.80632290514;12922.224666519993;12956.870431295683;12956.935215323934;12974.80537791934;666.8899631560798;814.071957967914;824.785555755502;829.2702421868747;832.2551316571664;826.4008593769529;828.0394742099166;828.5360198288947;830.4062595244399;833.8999320081599;866.4411454611771;867.6529388244721;867.6963062927988;868.8132051608903;872.7425409504211;852.3735054734765;864.476991420188;865.6191275838673;865.9350548708873;867.5835598912525;634.7238951056305;634.8857205702972;637.7576520922066;637.8564822914807;639.0605809460086;12690.936545317214;12718.936405317914;12733.936330318382;13277.601671949857;13355.933220333836;13029.15310504814;13268;13269.800952985714;13321.067525273234;13349;10620.294225599417;10728.141748660166;10820.72948176294;10953.945230273877;10993.175511836564;3657.561092668897;3702.4631428442995;3712.870049548253;3720.3489389356755;3733.3280009598534;48178.7591062046;48376.758116209196;48799.51200487985;48821.26768098481;49321.753391232814;10061.346012509164;10090.949545252373;10175.898241017643;10191.184705223564;10391.37651740898;17595.64808703819;17722;17762.733558996624;18473.7228941566;18680;7808;7861;7923;7987.32107770846;8258.834823303621;4154.626083652425;4208.516020657602;4222.831086756557;4275.87172384829;4348.5216626171095;2970.123813474987;2993.0571869860923;3003.0240171944206;3013.4726422876347;3014.2012366722397;590.5482306035886;601.0863487498978;609.1563184988822;609.7774312375951;610.7282259394527;477.36748807829764;581.348889244041;619.7366119399237;626.0765371077624;627.5262177056293;7700.460967732205;8000.679972801139;8159.632816523271;8173.509589424653;8185.523906459752;593.839663290909;624.6158612453399;629.7323637454064;634.1280738983897;645.0815009028136;3793.525809273841;3903.160820423566;3932.8225987572796;3968.5634580196156;3986.80065996699;57549.712251438476;58207.70896145492;58695.706521467975;58993;59100.70449647724;50037;50137;50572.24141637878;51042.74478627658;51300.23049654258;44720.55279447229;45517.31724024142;45842.312365314545;46427.30359044617;46475.767621162355;7253.9844421779935;7859.4891332063235;7917.604119794102;7927.603619819101;8065.1934806518875;35337;35654;35783.46324805078;36420.27159456849;36456;44522.10955780931;45432.545674544155;45541.31688024748;45618.54381456143;45745.31382029206;9745.805083898424;9827.361221520578;9869.506524673881;10173.135283500986;10229.43738094412;10014.19886409071;10260.692179234635;10601.522931468257;10619.415932123498;10729.302595331279;9944.403335799876;10037.949810250902;10358.378497289885;10670.253082284165;10714.25000249975;10517.39770210618;10660;10693.358398496115;10697.304675196086;10798.73003174927;9969.052939970692;10461.9476902615;11981.700457488632;12276.938615306866;12691.301978391277;9584.28117891175;9739.364889154956;9779.608815647294;9801.313908026656;10354.585816567253;8962.372633915564;9042.864357034781;9218;9677.274204434554;9710.951445242728 20:10:49 INFO - PROCESS | 9347 | __end_tp_report 20:10:49 INFO - PROCESS | 9347 | __start_cc_report 20:10:49 INFO - PROCESS | 9347 | _x_x_mozilla_cycle_collect,323 20:10:49 INFO - PROCESS | 9347 | __end_cc_report 20:10:49 INFO - PROCESS | 9347 | __startTimestamp1456546249930__endTimestamp 20:10:49 INFO - PROCESS | 9347 | 20:10:49 INFO - PROCESS | 9347 | ------- Summary: start ------- 20:10:49 INFO - PROCESS | 9347 | Number of tests: 6 20:10:49 INFO - PROCESS | 9347 | 20:10:49 INFO - PROCESS | 9347 | [#0] dojo.html Cycles:165 Average:5218.46 Median:5421.30 stddev:700.92 (12.9%) stddev-sans-first:684.99 20:10:49 INFO - PROCESS | 9347 | Values: 3201.8 3202.4 3251.2 3252.7 3259.3 5162.9 5169.5 5209.3 5218.4 5218.8 5169.8 5172.6 5182.6 5200.6 5311.4 4762.8 4773.6 4834.5 4839.6 4883.3 193.6 4797.1 4816.4 4852.7 4877.6 4686.4 4738.8 4804.9 4805.9 4836.3 4793.0 4807.4 4820.2 4822.3 4860.3 4702.5 4756.1 4783.2 4826.7 4857.4 5084.0 5099.1 5107.6 5121.7 5171.3 5580.6 5668.7 5671.7 5672.3 5737.5 5574.4 5644.5 5692.0 5700.4 5703.0 5325.8 5333.6 5347.5 5365.7 5372.9 5778.8 5781.0 5792.3 5795.9 5800.1 5464.6 5578.1 5628.7 5639.5 5653.3 5576.2 5600.4 5614.1 5614.4 5621.9 5543.1 5564.0 5564.4 5567.1 5571.5 5536.0 5585.0 5631.9 5650.0 5680.0 4307.0 4309.9 4311.2 4314.0 4337.7 3809.1 3891.6 3892.7 3904.5 3941.9 5303.4 5314.8 5364.8 5366.3 5396.7 5627.2 5644.2 5659.3 5663.0 5667.1 5296.1 5334.5 5357.8 5392.6 5397.5 4805.1 4805.9 4807.6 4813.2 4851.0 5963.1 5993.4 6016.5 6026.3 6033.4 5527.6 5617.7 5664.0 5674.7 5684.0 5922.8 5959.7 5966.4 5978.5 6000.0 5528.4 5536.4 5538.5 5568.3 5592.0 5585.4 5645.7 5646.2 5658.1 5710.2 5476.5 5523.5 5534.3 5542.2 5555.5 5496.0 5511.5 5518.6 5528.2 5576.1 5310.9 5329.9 5400.2 5460.0 5465.9 5454.7 5480.2 5481.2 5517.4 5519.6 5350.4 5364.9 5381.0 5397.5 5421.3 20:10:49 INFO - PROCESS | 9347 | 20:10:49 INFO - PROCESS | 9347 | [#1] ext.html Cycles:180 Average:48122.62 Median:36422.82 stddev:86823.30 (238.4%) stddev-sans-first:86993.30 20:10:49 INFO - PROCESS | 9347 | Values: 520.5 525.0 571.0 592.0 595.2 36036.5 36079.5 36287.3 36635.5 36733.0 40042.0 40371.4 40379.4 40415.2 40507.8 8462.7 8669.9 8690.3 8701.3 8717.6 8488.6 8598.1 8598.7 8617.5 8653.9 8754.9 8787.9 8794.7 8795.2 8823.0 8755.1 8802.9 8804.0 8813.8 8835.0 8777.4 8887.2 8899.2 8913.7 8918.2 40208.2 40267.6 40679.8 40682.0 40742.8 3166.3 3261.2 3390.5 3396.6 3478.8 27000.9 27043.2 27386.6 27660.7 27679.7 3695.4 3731.4 3740.6 3867.3 3907.5 270141.0 270297.0 271628.0 272099.0 273040.0 41092.6 61015.0 61291.4 61435.7 61514.7 39908.4 40057.2 40109.6 40192.4 40265.8 13599.3 13838.1 13858.8 13862.6 13889.9 10768.1 10778.7 10816.1 10837.0 10961.2 13673.5 13766.9 14255.4 14262.1 14310.9 5774.8 5803.4 5809.9 5843.6 5884.7 943.5 993.8 999.2 1022.7 1072.9 28866.3 29092.9 29212.4 29265.9 29338.7 1044.7 1056.8 1074.2 1110.1 1147.6 14830.6 15122.8 15365.8 16393.3 16467.5 403192.0 407683.0 410141.0 411398.0 414615.0 55640.7 55772.7 56340.4 56437.7 56465.7 1294.8 1333.7 1336.0 1340.4 1345.1 29180.7 30538.2 30620.0 30727.5 30913.8 45296.8 45503.8 45854.5 45879.3 45924.8 288983.0 290802.0 292123.0 292258.0 292602.0 31290.5 31380.5 31779.0 31856.8 32019.7 41782.0 42157.8 42849.6 42881.1 43134.6 35373.8 35712.1 35750.6 36089.0 36401.8 34198.3 34807.1 35212.3 35226.3 35386.0 36228.3 36443.8 39169.4 39760.0 40039.4 31023.0 32833.0 33763.5 33798.7 33859.3 25000.5 25329.2 25586.6 25597.5 25863.0 20:10:49 INFO - PROCESS | 9347 | 20:10:49 INFO - PROCESS | 9347 | [#2] jquery.html Cycles:180 Average:24920.88 Median:17798.90 stddev:67743.27 (380.6%) stddev-sans-first:67908.18 20:10:49 INFO - PROCESS | 9347 | Values: 350.8 356.2 358.3 359.2 359.8 16991.5 17247.9 17433.4 17601.9 17649.2 13428.5 14200.3 16578.8 16700.7 16706.0 5291.5 5313.8 5424.8 5437.0 5496.8 5325.7 5369.1 5383.7 5384.4 5426.7 5277.5 5293.8 5319.5 5337.0 5343.6 5219.0 5219.3 5323.3 5344.1 5369.3 4682.3 4755.1 4777.8 4783.3 4792.0 20799.7 21245.5 21317.9 21418.0 21565.8 2136.2 2210.5 2390.5 2568.2 2727.8 13170.3 13232.3 13401.5 13577.1 13794.0 1886.1 1931.6 1943.6 1950.4 1960.4 53965.0 60483.4 64233.4 66390.3 67929.0 10058.0 10189.8 10421.9 10447.3 10586.5 13628.4 13638.8 13692.7 13727.5 13758.0 7110.8 7281.3 7365.5 7412.4 7425.6 7169.0 7178.9 7203.0 7265.0 7395.5 4279.0 4347.2 4348.8 4416.6 4443.2 1693.9 1706.2 1711.7 1719.6 1725.8 884.6 913.1 915.0 925.9 936.6 16597.9 16639.3 17134.2 17274.6 17422.3 903.6 913.1 919.2 974.3 1003.4 9956.8 10050.2 10115.6 10123.6 10133.6 403290.0 406048.0 415570.0 418247.0 420273.0 61417.7 72611.3 74710.3 75323.0 77424.0 1034.3 1046.0 1057.9 1069.9 1070.9 16195.9 16257.6 16302.4 16532.3 16830.1 34694.0 35247.0 35464.8 36063.8 37011.6 50330.7 50967.5 51281.4 51693.2 51797.5 7758.3 7795.3 7869.6 8037.7 8280.8 9019.1 12087.7 12585.4 12738.2 13060.6 10577.9 11035.5 11122.7 11368.0 11408.0 11100.5 11104.6 11121.7 11140.3 11332.9 11258.8 11443.5 11469.3 11578.5 11622.2 7981.2 8018.6 8139.1 8140.5 8460.4 10907.5 11394.9 11477.8 11556.8 11575.4 20:10:49 INFO - PROCESS | 9347 | 20:10:49 INFO - PROCESS | 9347 | [#3] mootools.html Cycles:180 Average:5361.50 Median:6329.83 stddev:2805.36 (44.3%) stddev-sans-first:2798.04 20:10:49 INFO - PROCESS | 9347 | Values: 1477.6 1478.1 1637.9 1676.5 1770.7 7472.0 7588.6 7724.2 7729.1 7732.4 7611.2 7674.0 7710.6 7711.8 7769.5 2269.3 2301.1 2301.3 2301.9 2305.1 2256.9 2286.3 2291.9 2295.0 2295.1 2274.4 2275.4 2286.0 2311.7 2317.5 2273.1 2295.7 2310.9 2320.6 2326.1 2259.8 2260.8 2275.4 2281.1 2282.2 7717.9 7800.6 7840.1 7846.1 7866.6 4609.6 4706.6 4717.9 4732.2 4734.4 2951.5 2970.6 3065.3 3094.9 3110.0 975.5 986.9 1003.0 1009.8 1028.2 10584.6 10614.9 10673.2 10691.6 10769.1 3924.5 3961.1 4043.9 4045.7 4072.7 8458.1 8492.7 8498.7 8504.4 8522.9 4600.5 4605.8 4626.8 4628.1 4629.7 3790.1 4127.9 4203.5 4217.9 4225.3 3440.4 3451.2 3465.4 3487.2 3512.7 1010.5 1045.9 1047.4 1055.3 1056.7 1301.3 1304.4 1304.8 1343.0 1355.5 7244.7 7297.5 7426.5 7457.7 7461.2 454.3 459.6 460.8 465.5 467.4 5336.9 5420.4 5438.9 5442.5 5460.3 8941.1 9074.0 9453.9 9468.3 9479.2 9139.2 9154.0 9242.9 9309.9 9323.8 6819.6 6990.7 7000.2 7278.8 7388.8 7139.3 7167.2 7210.3 7213.9 7268.4 7880.5 8211.8 8218.7 8268.3 8356.8 8453.9 8493.7 8545.7 8580.8 8589.3 6087.0 6513.6 6713.6 6825.2 6928.5 7475.7 7507.6 7512.2 7544.0 7565.4 6505.3 6535.6 6649.7 6714.9 6942.3 6707.5 6715.7 6776.8 6783.6 6787.6 7082.0 7138.8 7149.9 7158.3 7221.9 6321.2 6328.7 6330.9 6341.2 6362.0 6426.3 6458.3 6485.9 6509.7 6524.6 20:10:49 INFO - PROCESS | 9347 | 20:10:49 INFO - PROCESS | 9347 | [#4] prototype.html Cycles:180 Average:5472.61 Median:6263.89 stddev:1723.96 (27.5%) stddev-sans-first:1684.52 20:10:49 INFO - PROCESS | 9347 | Values: 300.4 301.6 307.5 315.2 315.6 6024.6 6124.6 6176.2 6215.3 6224.3 6099.2 6101.6 6112.2 6114.4 6133.0 4463.3 4556.7 4580.0 4651.2 4686.5 4622.1 4636.6 4639.9 4647.9 4655.0 4558.6 4568.9 4593.2 4612.7 4613.5 4600.7 4600.8 4610.2 4616.3 4616.8 3958.5 3978.9 3979.2 3982.0 3986.6 5941.3 5948.7 5950.6 5953.3 5956.3 5214.3 5310.7 5319.1 5330.6 5342.0 6504.5 6521.3 6535.8 6543.5 6544.5 4301.8 4344.1 4344.9 4357.9 4365.6 6733.9 6825.3 6830.5 6847.7 6877.8 4452.2 4475.1 4479.6 4479.9 4484.9 4343.1 4475.0 4500.8 4514.9 4524.5 5305.7 5309.3 5323.2 5326.7 5331.9 6519.5 6576.9 6577.6 6591.9 6593.5 1579.0 1597.0 1598.2 1599.1 1600.3 1001.6 1015.1 1027.4 1043.6 1047.5 6297.0 6319.7 6331.7 6356.2 6371.6 6686.8 6744.8 6781.2 6790.1 6806.6 6274.1 6293.9 6295.9 6438.6 6458.6 3649.3 3660.4 3699.7 3705.5 3712.8 7298.9 7311.5 7322.8 7323.2 7340.1 6980.2 6980.9 6994.4 7005.8 7007.7 7119.2 7282.9 7295.1 7321.3 7347.5 6808.7 6810.6 6815.5 6835.0 6841.6 6724.9 6733.9 6751.2 6754.0 6766.8 7245.1 7305.9 7306.2 7322.9 7323.6 4330.7 4421.6 4422.4 4424.6 4437.0 6794.3 6835.7 6857.7 6862.8 6873.7 6592.8 6596.1 6600.4 6612.3 6618.6 6563.4 6572.9 6610.4 6618.9 6622.2 6253.7 6458.8 6500.0 6515.9 6519.1 6621.7 6641.8 6645.1 6666.8 6667.9 6459.9 6464.8 6480.1 6511.5 6518.5 20:10:49 INFO - PROCESS | 9347 | 20:10:49 INFO - PROCESS | 9347 | [#5] yui.html Cycles:180 Average:13713.23 Median:23476.57 stddev:16087.65 (68.5%) stddev-sans-first:16102.93 20:10:49 INFO - PROCESS | 9347 | Values: 664.1 665.1 730.4 829.6 832.0 13063.9 13261.3 13276.0 13283.7 13298.6 12911.8 12922.2 12956.9 12956.9 12974.8 666.9 814.1 824.8 829.3 832.3 826.4 828.0 828.5 830.4 833.9 866.4 867.7 867.7 868.8 872.7 852.4 864.5 865.6 865.9 867.6 634.7 634.9 637.8 637.9 639.1 12690.9 12718.9 12733.9 13277.6 13355.9 13029.2 13268.0 13269.8 13321.1 13349.0 10620.3 10728.1 10820.7 10953.9 10993.2 3657.6 3702.5 3712.9 3720.3 3733.3 48178.8 48376.8 48799.5 48821.3 49321.8 10061.3 10090.9 10175.9 10191.2 10391.4 17595.6 17722.0 17762.7 18473.7 18680.0 7808.0 7861.0 7923.0 7987.3 8258.8 4154.6 4208.5 4222.8 4275.9 4348.5 2970.1 2993.1 3003.0 3013.5 3014.2 590.5 601.1 609.2 609.8 610.7 477.4 581.3 619.7 626.1 627.5 7700.5 8000.7 8159.6 8173.5 8185.5 593.8 624.6 629.7 634.1 645.1 3793.5 3903.2 3932.8 3968.6 3986.8 57549.7 58207.7 58695.7 58993.0 59100.7 50037.0 50137.0 50572.2 51042.7 51300.2 44720.6 45517.3 45842.3 46427.3 46475.8 7254.0 7859.5 7917.6 7927.6 8065.2 35337.0 35654.0 35783.5 36420.3 36456.0 44522.1 45432.5 45541.3 45618.5 45745.3 9745.8 9827.4 9869.5 10173.1 10229.4 10014.2 10260.7 10601.5 10619.4 10729.3 9944.4 10037.9 10358.4 10670.3 10714.3 10517.4 10660.0 10693.4 10697.3 10798.7 9969.1 10461.9 11981.7 12276.9 12691.3 9584.3 9739.4 9779.6 9801.3 10354.6 8962.4 9042.9 9218.0 9677.3 9711.0 20:10:49 INFO - PROCESS | 9347 | -------- Summary: end -------- 20:10:49 INFO - PROCESS | 9347 | 20:10:50 INFO - PROCESS | 9347 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:50 INFO - PROCESS | 9347 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:50 INFO - PROCESS | 9347 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:50 INFO - PROCESS | 9347 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:50 INFO - PROCESS | 9347 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:50 INFO - PROCESS | 9347 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:50 INFO - PROCESS | 9347 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:50 INFO - PROCESS | 9347 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:50 INFO - PROCESS | 9347 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:50 INFO - TEST-INFO | 9347: exit 0 20:10:50 INFO - TEST-OK | dromaeo_css | took 1110204ms 20:10:50 INFO - TEST-START | kraken 20:10:50 INFO - operating with platform_type : linux_ 20:10:50 INFO - Initialising browser for kraken test... 20:10:50 INFO - TEST-INFO | started process 9574 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEmAK1C/profile http://localhost:34009/getInfo.html) 20:10:54 INFO - PROCESS | 9574 | 20:10:54 INFO - PROCESS | 9574 | (process:9646): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:10:54 INFO - PROCESS | 9574 | __metrics Screen width/height:1600/1200 20:10:54 INFO - PROCESS | 9574 | colorDepth:24 20:10:54 INFO - PROCESS | 9574 | Browser inner width/height: 1024/697 20:10:54 INFO - PROCESS | 9574 | __metrics 20:10:55 ERROR - PROCESS | 9574 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 20:10:55 INFO - PROCESS | 9574 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:55 INFO - PROCESS | 9574 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:55 INFO - PROCESS | 9574 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:55 INFO - PROCESS | 9574 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:55 INFO - PROCESS | 9574 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:55 INFO - PROCESS | 9574 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:55 INFO - PROCESS | 9574 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:55 INFO - PROCESS | 9574 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:55 INFO - PROCESS | 9574 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:56 INFO - TEST-INFO | 9574: exit 0 20:10:56 INFO - Browser initialized. 20:10:56 INFO - Running cycle 1/1 for kraken test... 20:10:56 INFO - TEST-INFO | started process 9697 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEmAK1C/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:57 INFO - PROCESS | 9697 | 20:10:57 INFO - PROCESS | 9697 | (process:9755): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:11:08 INFO - PROCESS | 9697 | RSS: Main: 158400512 20:11:08 INFO - PROCESS | 9697 | 20:11:10 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34009/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:11 INFO - PROCESS | 9697 | RSS: Main: 164691968 20:11:11 INFO - PROCESS | 9697 | 20:11:14 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34009/tests/kraken/driver.html?testName=audio-dft) 20:11:14 INFO - PROCESS | 9697 | RSS: Main: 166924288 20:11:14 INFO - PROCESS | 9697 | 20:11:17 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34009/tests/kraken/driver.html?testName=audio-fft) 20:11:18 INFO - PROCESS | 9697 | RSS: Main: 161873920 20:11:18 INFO - PROCESS | 9697 | 20:11:20 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34009/tests/kraken/driver.html?testName=audio-oscillator) 20:11:20 INFO - PROCESS | 9697 | RSS: Main: 162402304 20:11:20 INFO - PROCESS | 9697 | 20:11:22 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34009/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:23 INFO - PROCESS | 9697 | RSS: Main: 162119680 20:11:23 INFO - PROCESS | 9697 | 20:11:26 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34009/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:27 INFO - PROCESS | 9697 | RSS: Main: 162443264 20:11:27 INFO - PROCESS | 9697 | 20:11:30 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34009/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:31 INFO - PROCESS | 9697 | RSS: Main: 162861056 20:11:31 INFO - PROCESS | 9697 | 20:11:33 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34009/tests/kraken/driver.html?testName=json-parse-financial) 20:11:34 INFO - PROCESS | 9697 | RSS: Main: 163258368 20:11:34 INFO - PROCESS | 9697 | 20:11:36 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34009/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:11:36 INFO - PROCESS | 9697 | RSS: Main: 163868672 20:11:36 INFO - PROCESS | 9697 | 20:11:38 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:11:39 INFO - PROCESS | 9697 | RSS: Main: 163074048 20:11:39 INFO - PROCESS | 9697 | 20:11:41 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:11:41 INFO - PROCESS | 9697 | RSS: Main: 163872768 20:11:41 INFO - PROCESS | 9697 | 20:11:44 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:11:44 INFO - PROCESS | 9697 | RSS: Main: 163635200 20:11:44 INFO - PROCESS | 9697 | 20:11:47 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:48 INFO - PROCESS | 9697 | RSS: Main: 163696640 20:11:48 INFO - PROCESS | 9697 | 20:11:49 INFO - PROCESS | 9697 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34009/tests/kraken/driver.html?testName=ai-astar) 20:11:50 INFO - PROCESS | 9697 | RSS: Main: 163950592 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | __start_tp_report 20:11:50 INFO - PROCESS | 9697 | _x_x_mozilla_page_load 20:11:50 INFO - PROCESS | 9697 | _x_x_mozilla_page_load_details 20:11:50 INFO - PROCESS | 9697 | |i|pagename|runs| 20:11:50 INFO - PROCESS | 9697 | |0;ai-astar;112;108;112;112;113;123;111;111;111;113 20:11:50 INFO - PROCESS | 9697 | |1;audio-beat-detection;159;129;151;173;130;157;154;127;171;125 20:11:50 INFO - PROCESS | 9697 | |2;audio-dft;162;165;162;166;163;163;163;169;169;163 20:11:50 INFO - PROCESS | 9697 | |3;audio-fft;73;74;72;74;74;159;73;75;73;76 20:11:50 INFO - PROCESS | 9697 | |4;audio-oscillator;95;96;154;94;95;100;149;94;96;135 20:11:50 INFO - PROCESS | 9697 | |5;imaging-gaussian-blur;120;116;115;116;115;115;115;115;116;116 20:11:50 INFO - PROCESS | 9697 | |6;imaging-darkroom;147;147;146;150;147;146;148;145;147;146 20:11:50 INFO - PROCESS | 9697 | |7;imaging-desaturate;96;96;96;96;96;97;97;97;97;96 20:11:50 INFO - PROCESS | 9697 | |8;json-parse-financial;58;59;57;56;56;57;59;67;57;59 20:11:50 INFO - PROCESS | 9697 | |9;json-stringify-tinderbox;68;69;69;69;70;69;68;69;69;69 20:11:50 INFO - PROCESS | 9697 | |10;stanford-crypto-aes;83;81;85;85;84;83;83;83;85;83 20:11:50 INFO - PROCESS | 9697 | |11;stanford-crypto-ccm;135;116;121;117;122;127;121;124;119;122 20:11:50 INFO - PROCESS | 9697 | |12;stanford-crypto-pbkdf2;144;143;154;155;155;144;146;151;151;155 20:11:50 INFO - PROCESS | 9697 | |13;stanford-crypto-sha256-iterative;76;71;71;69;75;69;67;70;72;69 20:11:50 INFO - PROCESS | 9697 | __end_tp_report 20:11:50 INFO - PROCESS | 9697 | __start_cc_report 20:11:50 INFO - PROCESS | 9697 | _x_x_mozilla_cycle_collect,790 20:11:50 INFO - PROCESS | 9697 | __end_cc_report 20:11:50 INFO - PROCESS | 9697 | __startTimestamp1456546310109__endTimestamp 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | ------- Summary: start ------- 20:11:50 INFO - PROCESS | 9697 | Number of tests: 14 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.00 stddev:3.92 (3.5%) stddev-sans-first:4.15 20:11:50 INFO - PROCESS | 9697 | Values: 112.0 108.0 112.0 112.0 113.0 123.0 111.0 111.0 111.0 113.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:155.50 stddev:18.42 (11.8%) stddev-sans-first:19.07 20:11:50 INFO - PROCESS | 9697 | Values: 159.0 129.0 151.0 173.0 130.0 157.0 154.0 127.0 171.0 125.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.68 (1.6%) stddev-sans-first:2.68 20:11:50 INFO - PROCESS | 9697 | Values: 162.0 165.0 162.0 166.0 163.0 163.0 163.0 169.0 169.0 163.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#3] audio-fft Cycles:10 Average:82.30 Median:74.00 stddev:26.97 (36.5%) stddev-sans-first:28.40 20:11:50 INFO - PROCESS | 9697 | Values: 73.0 74.0 72.0 74.0 74.0 159.0 73.0 75.0 73.0 76.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:94.50 stddev:24.79 (26.2%) stddev-sans-first:25.62 20:11:50 INFO - PROCESS | 9697 | Values: 95.0 96.0 154.0 94.0 95.0 100.0 149.0 94.0 96.0 135.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.00 stddev:1.52 (1.3%) stddev-sans-first:0.53 20:11:50 INFO - PROCESS | 9697 | Values: 120.0 116.0 115.0 116.0 115.0 115.0 115.0 115.0 116.0 116.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 20:11:50 INFO - PROCESS | 9697 | Values: 147.0 147.0 146.0 150.0 147.0 146.0 148.0 145.0 147.0 146.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:11:50 INFO - PROCESS | 9697 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 97.0 97.0 97.0 96.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:3.21 (5.5%) stddev-sans-first:3.40 20:11:50 INFO - PROCESS | 9697 | Values: 58.0 59.0 57.0 56.0 56.0 57.0 59.0 67.0 57.0 59.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 20:11:50 INFO - PROCESS | 9697 | Values: 68.0 69.0 69.0 69.0 70.0 69.0 68.0 69.0 69.0 69.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:1.27 (1.5%) stddev-sans-first:1.33 20:11:50 INFO - PROCESS | 9697 | Values: 83.0 81.0 85.0 85.0 84.0 83.0 83.0 83.0 85.0 83.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:122.00 stddev:5.46 (4.5%) stddev-sans-first:3.39 20:11:50 INFO - PROCESS | 9697 | Values: 135.0 116.0 121.0 117.0 122.0 127.0 121.0 124.0 119.0 122.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:152.50 stddev:5.05 (3.3%) stddev-sans-first:4.90 20:11:50 INFO - PROCESS | 9697 | Values: 144.0 143.0 154.0 155.0 155.0 144.0 146.0 151.0 151.0 155.0 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:2.81 (4.0%) stddev-sans-first:2.29 20:11:50 INFO - PROCESS | 9697 | Values: 76.0 71.0 71.0 69.0 75.0 69.0 67.0 70.0 72.0 69.0 20:11:50 INFO - PROCESS | 9697 | -------- Summary: end -------- 20:11:50 INFO - PROCESS | 9697 | 20:11:50 INFO - PROCESS | 9697 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:11:50 INFO - PROCESS | 9697 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:11:50 INFO - PROCESS | 9697 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:11:50 INFO - PROCESS | 9697 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:11:50 INFO - PROCESS | 9697 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:11:50 INFO - PROCESS | 9697 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:11:50 INFO - PROCESS | 9697 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:11:51 INFO - TEST-INFO | 9697: exit 0 20:11:51 INFO - TEST-OK | kraken | took 60453ms 20:11:51 INFO - SUITE-END | took 1170s 20:11:51 INFO - Completed test suite (00:19:30) 20:11:51 INFO - Working with test: dromaeo_css 20:11:51 INFO - Generating results file: dromaeo_css 20:11:51 INFO - Working with test: kraken 20:11:51 INFO - Generating results file: kraken 20:11:51 INFO - javascript benchmark 20:11:51 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:11:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:11:51 INFO - process_Request line: dromaeo_css 6862.36 graph.html#tests=[[72,64,43]] 20:11:51 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:11:51 INFO - process_Request line: kraken 1531.00 graph.html#tests=[[232,64,43]] 20:11:51 INFO - RETURN: dromaeo_css: 6862.36 20:11:51 INFO - RETURN: kraken: 1531.00 20:11:51 INFO - javascript benchmark 20:11:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3201.7758756887015, 3202.4395730747115, 3251.170951407391, 3252.7397808175347, 3259.2829577492944, 5162.922556161656, 5169.534741873231, 5209.296744939432, 5218.373795144583, 5218.843434696955, 5169.844904652867, 5172.586193104552, 5182.559482443997, 5200.557952574026, 5311.389190243123, 4762.809487620491, 4773.641976851742, 4834.468208497063, 4839.637027222955, 4883.340748998875, 193.62398444776554, 4797.136515427222, 4816.422029356482, 4852.684575502599, 4877.634177436688, 4686.367340409052, 4738.8341408050555, 4804.879878003043, 4805.927911081337, 4836.298736683161, 4792.95207047932, 4807.351007613962, 4820.156472617313, 4822.300766388854, 4860.343853579757, 4702.5297470253045, 4756.143894099096, 4783.162946484351, 4826.734529600871, 4857.392825896763, 5084.0, 5099.082165210298, 5107.565856902131, 5121.743912804345, 5171.327727395452, 5580.581456390787, 5668.68822214778, 5671.6597004179885, 5672.34768001681, 5737.540996720252, 5574.386817450078, 5644.463775941279, 5692.0, 5700.37295897451, 5703.0, 5325.840224793263, 5333.626646134772, 5347.46525347466, 5365.651232669864, 5372.946270537283, 5778.8266352009505, 5780.971095144498, 5792.304923409218, 5795.913061304083, 5800.100984347433, 5464.644798088111, 5578.079616863172, 5628.690422026746, 5639.492445679908, 5653.321601407857, 5576.191452239484, 5600.383957764642, 5614.101743721067, 5614.438556144353, 5621.943780562142, 5543.113101903676, 5564.0, 5564.387917329091, 5567.053600887859, 5571.526420254243, 5535.972320138373, 5585.0, 5631.915521267184, 5650.039493286069, 5679.971600141973, 4306.978465107717, 4309.900975251291, 4311.223979683625, 4313.956860431355, 4337.674674399433, 3809.104860357814, 3891.591382904754, 3892.727509074338, 3904.4533765272886, 3941.92116157681, 5303.390110137384, 5314.840554783363, 5364.8122315718765, 5366.302380690485, 5396.730163491889, 5627.21219029328, 5644.153376993402, 5659.264295641623, 5662.971685141548, 5667.09326507765, 5296.09966305729, 5334.546563542142, 5357.7589008494715, 5392.568594512508, 5397.514223719884, 4805.087033463631, 4805.903881922342, 4807.61539076873, 4813.229883218738, 4850.975745121323, 5963.135345374896, 5993.400659934059, 6016.488598469179, 6026.306974697965, 6033.396660333931, 5527.5577953762795, 5617.719114044363, 5664.037113690682, 5674.659520428788, 5683.971580142238, 5922.822315330547, 5959.67221802805, 5966.373530779206, 5978.491828194652, 6000.009998350223, 5528.364238112668, 5536.446355364431, 5538.47384498472, 5568.276124103841, 5592.049351610155, 5585.413531579125, 5645.68948707825, 5646.209530665792, 5658.066419040812, 5710.2291190690385, 5476.534494567847, 5523.502884740393, 5534.335879694301, 5542.168674698827, 5555.527780138734, 5495.972520137374, 5511.53151982086, 5518.613697041169, 5528.226048353315, 5576.1356989666665, 5310.946890531045, 5329.866753331198, 5400.162974738922, 5460.0, 5465.863353416196, 5454.727263636723, 5480.232767412645, 5481.177823326533, 5517.393086760533, 5519.586031047607, 5350.411454740053, 5364.946350536601, 5380.973095134499, 5397.487238712316, 5421.295231619864], "unit": "score", "name": "dojo.html", "value": 5175.9566996450885}, {"lowerIsBetter": false, "replicates": [520.5263210478465, 525.0260766278551, 571.0007486897929, 591.9911201331978, 595.1994567306971, 36036.45945310819, 36079.458808117866, 36287.274254514894, 36635.45046824293, 36733.0, 40042.0, 40371.394429083586, 40379.394309085386, 40415.19169616606, 40507.79746101273, 8462.703805366798, 8669.869951950726, 8690.348223883235, 8701.259748050416, 8717.607707653171, 8488.575571221445, 8598.140185981383, 8598.742037738877, 8617.482951022926, 8653.913460865406, 8754.912450875474, 8787.912120878806, 8794.736157915273, 8795.208431241186, 8822.955885220565, 8755.124487551226, 8802.911970880337, 8803.955980220122, 8813.779655508599, 8835.0, 8777.42946708462, 8887.24458421035, 8899.154580314924, 8913.732588022369, 8918.152775486318, 40208.19583608341, 40267.597324026676, 40679.7966010171, 40682.0, 40742.796286018674, 3166.300105014968, 3261.2010057535817, 3390.5253264542985, 3396.6093899201414, 3478.826058697055, 27000.864995675092, 27043.1887043389, 27386.589201161998, 27660.723392766016, 27679.723202768117, 3695.4456831475227, 3731.365667836474, 3740.588535261119, 3867.323218436762, 3907.4920260366252, 270141.0, 270297.0, 271628.0, 272099.0, 273040.0, 41092.58907410948, 61015.0, 61291.38708612857, 61435.6928215365, 61514.69242653847, 39908.40137397941, 40057.1988560233, 40109.59890401117, 40192.39711404331, 40265.79867100646, 13599.252041137635, 13838.100523465942, 13858.792118118236, 13862.584122476343, 13889.930550347184, 10768.084712799344, 10778.676639700821, 10816.080633146114, 10837.0, 10961.232713709964, 13673.453061877612, 13766.862331376758, 14255.429782808571, 14262.144271343544, 14310.928445357707, 5774.82675519735, 5803.448672376117, 5809.941900581025, 5843.5909486336395, 5884.735186916599, 943.5188054092463, 993.7664648807524, 999.2405771613626, 1022.6676330192569, 1072.9195310351754, 28866.27834304159, 29092.854535727187, 29212.415751684846, 29265.85367073151, 29338.706612934024, 1044.7492601775518, 1056.7780766039064, 1074.188987314588, 1110.0730889707024, 1147.5926046253626, 14830.555083347517, 15122.773158402633, 15365.769513457308, 16393.34426622922, 16467.505974820775, 403192.0, 407683.0, 410141.0, 411398.0, 414615.0, 55640.72179639076, 55772.72113639406, 56340.43659563434, 56437.71781141068, 56465.7176714122, 1294.786360250567, 1333.693250552359, 1335.9599212023654, 1340.4102195034154, 1345.118947089658, 29180.70819291865, 30538.236544086576, 30620.0, 30727.539086913268, 30913.785328093556, 45296.773516132205, 45503.772481137385, 45854.54145458503, 45879.31181032354, 45924.770376147906, 288983.0, 290802.0, 292123.0, 292258.0, 292602.0, 31290.530642039932, 31380.529292061095, 31779.0, 31856.8407157972, 32019.67980320167, 41782.0, 42157.78921105375, 42849.571504284555, 42881.14237715166, 43134.56865431306, 35373.82313088418, 35712.10719732028, 35750.642493574735, 36089.0, 36401.817990909876, 34198.31603367869, 34807.129821753646, 35212.29575408529, 35226.29547409089, 35386.0, 36228.27543449169, 36443.817780910926, 39169.41245881257, 39760.0, 40039.39940900831, 31023.0, 32833.0, 33763.493547596314, 33798.66201337955, 33859.3228135431, 25000.499989999735, 25329.240122796346, 25586.61620075663, 25597.488050239263, 25863.0], "unit": "score", "name": "ext.html", "value": 17990.14221389352}, {"lowerIsBetter": false, "replicates": [350.8053030568034, 356.203884318548, 358.3442300589921, 359.1989862606388, 359.8344761409752, 16991.490255292345, 17247.91376043118, 17433.389831355904, 17601.91199044003, 17649.20578573964, 13428.530001449952, 14200.289985500709, 16578.75131873023, 16700.66598668029, 16706.0, 5291.497307755757, 5313.814016509423, 5424.83725488236, 5436.972815135919, 5496.80761173359, 5325.707086110262, 5369.087255166631, 5383.703896285702, 5384.380796208447, 5426.728663566825, 5277.525022747952, 5293.788248470057, 5319.494648008433, 5336.9733151334385, 5343.599230057742, 5219.034478621448, 5219.269302297681, 5323.334583177103, 5344.118220493614, 5369.275147855068, 4682.344471773954, 4755.096531658974, 4777.784999674988, 4783.3064205690325, 4792.0, 20799.68800467994, 21245.46886327854, 21317.893410533004, 21418.03618837156, 21565.78434215669, 2136.2202795979356, 2210.458437682762, 2390.497995420964, 2568.203856804378, 2727.7861351698502, 13170.34148292591, 13232.338383080807, 13401.46394144233, 13577.11748736329, 13794.0, 1886.1323791055993, 1931.5943651833131, 1943.640426521084, 1950.3953774330002, 1960.44127423685, 53965.0, 60483.39516604822, 64233.3576664232, 66390.3360966389, 67929.0, 10058.0, 10189.796204076025, 10421.895781042092, 10447.268691191695, 10586.4706764663, 13628.386722597506, 13638.795418068737, 13692.65768355779, 13727.519536816364, 13758.0, 7110.786676399716, 7281.308275713799, 7365.484416090822, 7412.369948554326, 7425.62871856405, 7168.964155179295, 7178.928210717931, 7203.027591275216, 7264.963675181591, 7395.519291246052, 4278.957210427856, 4347.239233134189, 4348.760818154969, 4416.580424859633, 4443.155800397914, 1693.9237734301987, 1706.1895599590096, 1711.6918954588045, 1719.5872990482444, 1725.8446739793228, 884.6372987075397, 913.1325241020924, 914.9935071421384, 925.9259259259243, 936.578539657157, 16597.941751260943, 16639.334426622798, 17134.228959696844, 17274.568135796704, 17422.303107875796, 903.6069309850236, 913.1005959130251, 919.1727445299284, 974.3471873844542, 1003.3528374198601, 9956.80086398268, 10050.246231532665, 10115.595376185018, 10123.59505619767, 10133.645322413828, 403290.0, 406048.0, 415570.0, 418247.0, 420273.0, 61417.69291153516, 72611.2738872615, 74710.25289747033, 75323.0, 77424.0, 1034.3018462537907, 1046.0062940206833, 1057.8730552333616, 1069.9197560183018, 1070.9303895246785, 16195.919020404823, 16257.61810246095, 16302.429414970893, 16532.338706452087, 16830.074345911093, 34694.0, 35247.0, 35464.82267588749, 36063.819680901426, 37011.62988370082, 50330.748346258035, 50967.490325096274, 51281.43772277593, 51693.22460163176, 51797.48202517926, 7758.301752842045, 7795.298423141944, 7869.567173805495, 8037.678492860454, 8280.83438331218, 9019.098090190928, 12087.697807554881, 12585.43365548571, 12738.235705857678, 13060.608181754562, 10577.9471102644, 11035.503402347074, 11122.666320010412, 11368.0, 11408.0, 11100.500477478694, 11104.5558177672, 11121.666350009513, 11140.33158010522, 11332.943335283271, 11258.831117533407, 11443.485043173243, 11469.31184128955, 11578.536858525902, 11622.244554104294, 7981.161977992228, 8018.599070046358, 8139.10469848328, 8140.470869393471, 8460.407771455939, 10907.509162087883, 11394.94302528482, 11477.82783258235, 11556.826647600124, 11575.42122893835], "unit": "score", "name": "jquery.html", "value": 8514.849514007836}, {"lowerIsBetter": false, "replicates": [1477.6379786952195, 1478.13529085485, 1637.9099149546778, 1676.4886709553582, 1770.7166853303465, 7471.962640186798, 7588.58262795546, 7724.227577242273, 7729.149793522708, 7732.420068494871, 7611.238876112386, 7674.0, 7710.57591832449, 7711.845763084735, 7769.494982826112, 2269.2511471214502, 2301.056566807609, 2301.309607117866, 2301.8964146613444, 2305.101010605865, 2256.898439570223, 2286.2569664858906, 2291.8854057297067, 2294.977050229493, 2295.104909085458, 2274.37454699958, 2275.4425165834396, 2286.039863257436, 2311.6763653088497, 2317.5017371265176, 2273.1134857405623, 2295.701558797354, 2310.9422264443438, 2320.6170981787986, 2326.069572171128, 2259.8418110732255, 2260.8417410781253, 2275.397019789757, 2281.0761641535205, 2282.1784157703214, 7717.922820771777, 7800.648970796327, 7840.0591928968315, 7846.097698764658, 7866.606669666494, 4609.562091601292, 4706.552877476634, 4717.905641887143, 4732.195526760459, 4734.384530011076, 2951.513000354939, 2970.5692674562283, 3065.2796592800673, 3094.8607312670983, 3109.9689003110134, 975.4781192062284, 986.9062439068277, 1003.0220534978411, 1009.8362601441066, 1028.228828378716, 10584.576616935314, 10614.946925265323, 10673.1995100367, 10691.625793097204, 10769.084627806567, 3924.489816323917, 3961.088949541564, 4043.8786836394956, 4045.7370270932297, 4072.6538244249573, 8458.111898250596, 8492.660293588311, 8498.74503764888, 8504.362172837062, 8522.87215691765, 4600.493945665974, 4605.838795642137, 4626.791794369262, 4628.074385122989, 4629.699069560468, 3790.1472168761807, 4127.876163715094, 4203.495580530294, 4217.915641687149, 4225.3239481683395, 3440.3807314683095, 3451.171718787473, 3465.4282043462545, 3487.197944472735, 3512.7189824813954, 1010.5099026971913, 1045.9215558833118, 1047.402980301221, 1055.2824079625927, 1056.6671498477954, 1301.3168086754529, 1304.3934570424608, 1304.8108024336607, 1343.033016228314, 1355.5120156743565, 7244.673989670478, 7297.489175757646, 7426.480146389809, 7457.7016919323705, 7461.216572259943, 454.33666846404617, 459.62081282941705, 460.75810199645457, 465.4530926161746, 467.35738359755334, 5336.866578335573, 5420.430854760272, 5438.864028399322, 5442.510174084351, 5460.262864513319, 8941.105889411007, 9074.0, 9453.905460945303, 9468.289878259158, 9479.194268487117, 9139.177474027369, 9154.038825923315, 9242.86135707965, 9309.860352094724, 9323.766905827408, 6819.5908245505425, 6990.650467476606, 7000.194977577644, 7278.781636550912, 7388.778336649909, 7139.286071392819, 7167.1757747859665, 7210.315020073084, 7213.927860721536, 7268.382187513909, 7880.527168369917, 8211.809287653376, 8218.671253150047, 8268.2558569729, 8356.832863342577, 8453.873191902003, 8493.702720404755, 8545.700900468453, 8580.785480363042, 8589.269912057545, 6087.0, 6513.609183449008, 6713.56361836479, 6825.180978282439, 6928.4803639726215, 7475.700971961278, 7507.624618769149, 7512.173660897406, 7543.962280188564, 7565.4325925556905, 6505.349465053457, 6535.57518761279, 6649.734010639714, 6714.899276510759, 6942.340477654615, 6707.496937729592, 6715.731370745116, 6776.796696099125, 6783.559068660521, 6787.5588086774205, 7081.964590177016, 7138.785836424916, 7149.857002860018, 7158.319959603829, 7221.891671625035, 6321.209848768904, 6328.7152078157515, 6330.936690633035, 6341.207349081365, 6361.982082866719, 6426.293107758236, 6458.257300410513, 6485.8702825944165, 6509.674516274262, 6524.641144737085], "unit": "score", "name": "mootools.html", "value": 4330.086468684127}, {"lowerIsBetter": false, "replicates": [300.39020787800746, 301.5612284126596, 307.5264093296323, 315.2497057004331, 315.57082367979535, 6024.638521688702, 6124.632522048681, 6176.227971503557, 6215.285242197148, 6224.284207316148, 6099.1766111574925, 6101.603395779282, 6112.174856394386, 6114.3579924108, 6133.0, 4463.33050042493, 4556.681032327739, 4580.0, 4651.209294419939, 4686.531346865312, 4622.121796858586, 4636.605888499482, 4639.930401043987, 4647.907041859161, 4655.0, 4558.61251793598, 4568.931466028012, 4593.242115051013, 4612.746298953556, 4613.492515823256, 4600.746958917275, 4600.792964316597, 4610.170169369512, 4616.28447590624, 4616.7691615419435, 3958.4853968984135, 3978.900527486807, 3979.243943650697, 3981.9601803981877, 3986.5614782374205, 5941.346451890288, 5948.702564871739, 5950.642961422329, 5953.345132035516, 5956.285245770492, 5214.270002199695, 5310.70791106489, 5319.069162896516, 5330.600204984603, 5341.973290133564, 6504.5121615878525, 6521.31526189748, 6535.836604084889, 6543.541952063358, 6544.541882068257, 4301.784910754481, 4344.087741574273, 4344.913101737948, 4357.869263922055, 4365.581186114526, 6733.8653226935185, 6825.283345248727, 6830.487713421464, 6847.657617119125, 6877.828054298632, 4452.243118669834, 4475.14972155296, 4479.641628669699, 4479.888002799956, 4484.865454036384, 4343.109662519176, 4474.977625111918, 4500.774961251925, 4514.909701806011, 4524.5249248828395, 5305.734713264322, 5309.283246761715, 5323.201519772065, 5326.707031113326, 5331.893362132736, 6519.543631945813, 6576.934230657728, 6577.6053436793945, 6591.934080659132, 6593.505487088488, 1579.0367875595878, 1596.960075998086, 1598.2408356031024, 1599.09651047158, 1600.2558810153334, 1001.6444162322416, 1015.0661391519819, 1027.440045175381, 1043.5773511727762, 1047.5076713944434, 6296.992481202986, 6319.684015799192, 6331.715072821734, 6356.237251529754, 6371.649559274284, 6686.765963191265, 6744.7976560703255, 6781.152355955505, 6790.117284752951, 6806.591604503746, 6274.121622972787, 6293.937060629427, 6295.905561416583, 6438.645874476949, 6458.644774537352, 3649.3431182387426, 3660.359437098497, 3699.6855267302044, 3705.5368078990127, 3712.832922518493, 7298.854022919512, 7311.524750891175, 7322.82834746438, 7323.194448610649, 7340.11918569775, 6980.162380514371, 6980.895286570705, 6994.405475534637, 7005.773989551808, 7007.684654190573, 7119.181294151239, 7282.890756638654, 7295.124585049828, 7321.267873212742, 7347.485676002735, 6808.65956702153, 6810.625415601991, 6815.522913396015, 6834.965825170842, 6841.589504629738, 6724.865502690017, 6733.898991515033, 6751.223609284995, 6753.966230168818, 6766.763163289262, 7245.094363204599, 7305.890411643936, 7306.1963184048645, 7322.926770732224, 7323.597202153933, 4330.718503297276, 4421.602055814992, 4422.3587579800105, 4424.557544245549, 4436.977815110904, 6794.286599907136, 6835.692393842389, 6857.691403886737, 6862.794116176523, 6873.656317184021, 6592.80221593353, 6596.109525214035, 6600.438962688226, 6612.338766123542, 6618.569792963442, 6563.409293163638, 6572.934270657423, 6610.3720146586, 6618.867622647616, 6622.205335359788, 6253.6560489173535, 6458.773942912164, 6499.967500162469, 6515.902261466176, 6519.1199188110895, 6621.702023409054, 6641.767538136142, 6645.069690243273, 6666.83332916681, 6667.933320666925, 6459.870802584016, 6464.806055818333, 6480.092787009917, 6511.544191906521, 6518.543701940818], "unit": "score", "name": "prototype.html", "value": 4892.997455814891}, {"lowerIsBetter": false, "replicates": [664.0935123556344, 665.0523004718275, 730.4302643937729, 829.5934991853993, 831.9875201871971, 13063.869361306384, 13261.270630115363, 13276.0, 13283.7343253135, 13298.601041968745, 12911.80632290514, 12922.224666519993, 12956.870431295683, 12956.935215323934, 12974.80537791934, 666.8899631560798, 814.071957967914, 824.785555755502, 829.2702421868747, 832.2551316571664, 826.4008593769529, 828.0394742099166, 828.5360198288947, 830.4062595244399, 833.8999320081599, 866.4411454611771, 867.6529388244721, 867.6963062927988, 868.8132051608903, 872.7425409504211, 852.3735054734765, 864.476991420188, 865.6191275838673, 865.9350548708873, 867.5835598912525, 634.7238951056305, 634.8857205702972, 637.7576520922066, 637.8564822914807, 639.0605809460086, 12690.936545317214, 12718.936405317914, 12733.936330318382, 13277.601671949857, 13355.933220333836, 13029.15310504814, 13268.0, 13269.800952985714, 13321.067525273234, 13349.0, 10620.294225599417, 10728.141748660166, 10820.72948176294, 10953.945230273877, 10993.175511836564, 3657.561092668897, 3702.4631428442995, 3712.870049548253, 3720.3489389356755, 3733.3280009598534, 48178.7591062046, 48376.758116209196, 48799.51200487985, 48821.26768098481, 49321.753391232814, 10061.346012509164, 10090.949545252373, 10175.898241017643, 10191.184705223564, 10391.37651740898, 17595.64808703819, 17722.0, 17762.733558996624, 18473.7228941566, 18680.0, 7808.0, 7861.0, 7923.0, 7987.32107770846, 8258.834823303621, 4154.626083652425, 4208.516020657602, 4222.831086756557, 4275.87172384829, 4348.5216626171095, 2970.123813474987, 2993.0571869860923, 3003.0240171944206, 3013.4726422876347, 3014.2012366722397, 590.5482306035886, 601.0863487498978, 609.1563184988822, 609.7774312375951, 610.7282259394527, 477.36748807829764, 581.348889244041, 619.7366119399237, 626.0765371077624, 627.5262177056293, 7700.460967732205, 8000.679972801139, 8159.632816523271, 8173.509589424653, 8185.523906459752, 593.839663290909, 624.6158612453399, 629.7323637454064, 634.1280738983897, 645.0815009028136, 3793.525809273841, 3903.160820423566, 3932.8225987572796, 3968.5634580196156, 3986.80065996699, 57549.712251438476, 58207.70896145492, 58695.706521467975, 58993.0, 59100.70449647724, 50037.0, 50137.0, 50572.24141637878, 51042.74478627658, 51300.23049654258, 44720.55279447229, 45517.31724024142, 45842.312365314545, 46427.30359044617, 46475.767621162355, 7253.9844421779935, 7859.4891332063235, 7917.604119794102, 7927.603619819101, 8065.1934806518875, 35337.0, 35654.0, 35783.46324805078, 36420.27159456849, 36456.0, 44522.10955780931, 45432.545674544155, 45541.31688024748, 45618.54381456143, 45745.31382029206, 9745.805083898424, 9827.361221520578, 9869.506524673881, 10173.135283500986, 10229.43738094412, 10014.19886409071, 10260.692179234635, 10601.522931468257, 10619.415932123498, 10729.302595331279, 9944.403335799876, 10037.949810250902, 10358.378497289885, 10670.253082284165, 10714.25000249975, 10517.39770210618, 10660.0, 10693.358398496115, 10697.304675196086, 10798.73003174927, 9969.052939970692, 10461.9476902615, 11981.700457488632, 12276.938615306866, 12691.301978391277, 9584.28117891175, 9739.364889154956, 9779.608815647294, 9801.313908026656, 10354.585816567253, 8962.372633915564, 9042.864357034781, 9218.0, 9677.274204434554, 9710.951445242728], "unit": "score", "name": "yui.html", "value": 6216.219727362701}], "name": "dromaeo_css", "value": 6862.353103227683}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 112.0, 113.0, 123.0, 111.0, 111.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [159.0, 129.0, 151.0, 173.0, 130.0, 157.0, 154.0, 127.0, 171.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 162.0, 166.0, 163.0, 163.0, 163.0, 169.0, 169.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 72.0, 74.0, 74.0, 159.0, 73.0, 75.0, 73.0, 76.0], "unit": "score", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 154.0, 94.0, 95.0, 100.0, 149.0, 94.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 150.0, 147.0, 146.0, 148.0, 145.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 57.0, 56.0, 56.0, 57.0, 59.0, 67.0, 57.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 85.0, 85.0, 84.0, 83.0, 83.0, 83.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [135.0, 116.0, 121.0, 117.0, 122.0, 127.0, 121.0, 124.0, 119.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [144.0, 143.0, 154.0, 155.0, 155.0, 144.0, 146.0, 151.0, 151.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [76.0, 71.0, 71.0, 69.0, 75.0, 69.0, 67.0, 70.0, 72.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1531.0000000000002}]} 20:11:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1531.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6862.36"}}} 20:11:51 INFO - Return code: 0 20:11:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:11:51 ERROR - # TBPL SUCCESS # 20:11:51 INFO - Running post-action listener: _resource_record_post_action 20:11:51 INFO - Running post-run listener: _resource_record_post_run 20:11:52 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538923008; Read time: 16; Write time: 476608 20:11:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240795648; Read time: 0; Write time: 252292 20:11:52 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298127360; Read time: 16; Write time: 224316 20:11:52 INFO - Running post-run listener: _upload_blobber_files 20:11:52 INFO - Blob upload gear active. 20:11:52 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:11:52 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:11:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:11:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:11:53 INFO - (blobuploader) - INFO - Open directory for files ... 20:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:53 INFO - (blobuploader) - INFO - Done attempting. 20:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:54 INFO - (blobuploader) - INFO - Done attempting. 20:11:54 INFO - (blobuploader) - INFO - Iteration through files over. 20:11:54 INFO - Return code: 0 20:11:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:11:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:11:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f0f846fe1aa388bc7285dcbbc402b5cb5ced5c17110628661855cc19b4860b386b84003e020309f614a953d05e18f55059242b08c989243ab80bcbd4b05edbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9256d387c209aa68c7bf3ebb9daf1f6c0b3318f6d4b241e6ef1548a8ce7bcb51a37f7db9da3644fb7dd4a06986aac7d4cc94aadbbc7dcb6074682e4f6d4224f"} 20:11:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:11:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:11:54 INFO - Contents: 20:11:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f0f846fe1aa388bc7285dcbbc402b5cb5ced5c17110628661855cc19b4860b386b84003e020309f614a953d05e18f55059242b08c989243ab80bcbd4b05edbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9256d387c209aa68c7bf3ebb9daf1f6c0b3318f6d4b241e6ef1548a8ce7bcb51a37f7db9da3644fb7dd4a06986aac7d4cc94aadbbc7dcb6074682e4f6d4224f"} 20:11:54 INFO - Running post-run listener: copy_logs_to_upload_dir 20:11:54 INFO - Copying logs to upload dir... 20:11:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:11:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.661283 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-26 20:11:54.222064) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 20:11:54.226153) ========= 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=232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f0f846fe1aa388bc7285dcbbc402b5cb5ced5c17110628661855cc19b4860b386b84003e020309f614a953d05e18f55059242b08c989243ab80bcbd4b05edbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9256d387c209aa68c7bf3ebb9daf1f6c0b3318f6d4b241e6ef1548a8ce7bcb51a37f7db9da3644fb7dd4a06986aac7d4cc94aadbbc7dcb6074682e4f6d4224f"} build_url:https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/VdJwJV4fRPi0soRjgeBYSg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f0f846fe1aa388bc7285dcbbc402b5cb5ced5c17110628661855cc19b4860b386b84003e020309f614a953d05e18f55059242b08c989243ab80bcbd4b05edbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9256d387c209aa68c7bf3ebb9daf1f6c0b3318f6d4b241e6ef1548a8ce7bcb51a37f7db9da3644fb7dd4a06986aac7d4cc94aadbbc7dcb6074682e4f6d4224f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 20:11:54.250562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 20:11:54.250879) ========= 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=232498196343f89f466a4a9a000001c8-1456543830.667203-1898216830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 20:11:54.334527) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 20:11:54.334858) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 20:11:54.335148) ========= ========= Total master_lag: 0.26 =========