builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1456804103.17 results: success (0) buildid: 20160229173007 builduid: 6f5a67bc2bde44c49cb900c451d1b9c5 revision: 1b2fddb62fcc4d1038f2e57b619a56c4f1837507 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.171288) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.171726) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.172049) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006364 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.211739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.212051) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.230939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.231237) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.281603) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.281912) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.282286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.282595) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 19:48:23-- 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% 18.4M=0.001s 2016-02-29 19:48:23 (18.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118058 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.419651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.420045) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021074 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.471848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:23.472205) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b2fddb62fcc4d1038f2e57b619a56c4f1837507 --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 1b2fddb62fcc4d1038f2e57b619a56c4f1837507 --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=edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 19:48:23,547 truncating revision to first 12 chars 2016-02-29 19:48:23,547 Setting DEBUG logging. 2016-02-29 19:48:23,548 attempt 1/10 2016-02-29 19:48:23,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b2fddb62fcc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 19:48:23,826 unpacking tar archive at: fx-team-1b2fddb62fcc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579871 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:24.068340) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:24.068734) ========= echo 1b2fddb62fcc4d1038f2e57b619a56c4f1837507 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1b2fddb62fcc4d1038f2e57b619a56c4f1837507'] 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=edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1b2fddb62fcc4d1038f2e57b619a56c4f1837507 program finished with exit code 0 elapsedTime=0.003827 script_repo_revision: '1b2fddb62fcc4d1038f2e57b619a56c4f1837507' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:24.119278) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:24.119900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 19:48:24.130459) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 56 secs) (at 2016-02-29 19:48:24.130996) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:48:24 INFO - MultiFileLogger online at 20160229 19:48:24 in /builds/slave/test-pgo 19:48:24 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:48:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:48:24 INFO - {'append_to_log': False, 19:48:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:48:24 INFO - 'blob_upload_branch': 'Fx-Team', 19:48:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:48:24 INFO - 'branch': 'Fx-Team', 19:48:24 INFO - 'buildbot_json_path': 'buildprops.json', 19:48:24 INFO - 'config_files': ('talos/linux_config.py',), 19:48:24 INFO - 'default_actions': ('clobber', 19:48:24 INFO - 'read-buildbot-config', 19:48:24 INFO - 'download-and-extract', 19:48:24 INFO - 'populate-webroot', 19:48:24 INFO - 'create-virtualenv', 19:48:24 INFO - 'install', 19:48:24 INFO - 'run-tests'), 19:48:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:48:24 INFO - 'download_minidump_stackwalk': True, 19:48:24 INFO - 'download_symbols': 'ondemand', 19:48:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:48:24 INFO - 'tooltool.py': '/tools/tooltool.py', 19:48:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:48:24 INFO - '/tools/misc-python/virtualenv.py')}, 19:48:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:48:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:48:24 INFO - 'installer_path': 'installer.exe', 19:48:24 INFO - 'log_level': 'info', 19:48:24 INFO - 'log_name': 'talos', 19:48:24 INFO - 'log_to_console': True, 19:48:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:48:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:48:24 INFO - 'opt_config_files': (), 19:48:24 INFO - 'pip_index': False, 19:48:24 INFO - 'sps_profile': False, 19:48:24 INFO - 'sps_profile_interval': 0, 19:48:24 INFO - 'suite': 'dromaeojs-e10s', 19:48:24 INFO - 'system_bits': '32', 19:48:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:48:24 INFO - 'title': 'talos-linux64-ix-033', 19:48:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:48:24 INFO - 'use_talos_json': True, 19:48:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:48:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:48:24 INFO - 'work_dir': 'build'} 19:48:24 INFO - ##### 19:48:24 INFO - ##### Running clobber step. 19:48:24 INFO - ##### 19:48:24 INFO - Running pre-action listener: _resource_record_pre_action 19:48:24 INFO - Running main action method: clobber 19:48:24 INFO - rmtree: /builds/slave/test-pgo/build 19:48:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:48:24 INFO - Running post-action listener: _resource_record_post_action 19:48:24 INFO - ##### 19:48:24 INFO - ##### Running read-buildbot-config step. 19:48:24 INFO - ##### 19:48:24 INFO - Running pre-action listener: _resource_record_pre_action 19:48:24 INFO - Running main action method: read_buildbot_config 19:48:24 INFO - Using buildbot properties: 19:48:24 INFO - { 19:48:24 INFO - "project": "", 19:48:24 INFO - "product": "firefox", 19:48:24 INFO - "script_repo_revision": "production", 19:48:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:48:24 INFO - "repository": "", 19:48:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:48:24 INFO - "buildid": "20160229173007", 19:48:24 INFO - "pgo_build": "True", 19:48:24 INFO - "basedir": "/builds/slave/test-pgo", 19:48:24 INFO - "buildnumber": 535, 19:48:24 INFO - "slavename": "talos-linux64-ix-033", 19:48:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:48:24 INFO - "platform": "ubuntu64_hw", 19:48:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:48:24 INFO - "branch": "fx-team", 19:48:24 INFO - "repo_path": "integration/fx-team", 19:48:24 INFO - "revision": "1b2fddb62fcc4d1038f2e57b619a56c4f1837507", 19:48:24 INFO - "stage_platform": "linux64-pgo", 19:48:24 INFO - "builduid": "6f5a67bc2bde44c49cb900c451d1b9c5", 19:48:24 INFO - "slavebuilddir": "test" 19:48:24 INFO - } 19:48:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 19:48:24 INFO - Running post-action listener: _resource_record_post_action 19:48:24 INFO - ##### 19:48:24 INFO - ##### Running download-and-extract step. 19:48:24 INFO - ##### 19:48:24 INFO - Running pre-action listener: _resource_record_pre_action 19:48:24 INFO - Running main action method: download_and_extract 19:48:24 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:24 INFO - https://queue.taskcluster.net/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:48:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/test_packages.json 19:48:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/test_packages.json 19:48:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:48:26 INFO - Downloaded 1448 bytes. 19:48:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:48:26 INFO - Using the following test package requirements: 19:48:26 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:48:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:48:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:48:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:26 INFO - u'jsshell-linux-x86_64.zip'], 19:48:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:48:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:48:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:48:26 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:48:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:48:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:48:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:48:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:26 INFO - https://queue.taskcluster.net/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:48:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:48:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:48:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/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:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/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:48:29 INFO - Downloaded 23380327 bytes. 19:48: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:48: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:48:30 INFO - Return code: 0 19:48: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:48: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:48:30 INFO - https://queue.taskcluster.net/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/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:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/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:48:32 INFO - Downloaded 23380327 bytes. 19:48:32 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:48:32 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:48:39 INFO - Return code: 0 19:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:39 INFO - https://queue.taskcluster.net/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:48:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:48:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:48:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/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:48:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/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:48:40 INFO - Downloaded 10713410 bytes. 19:48:40 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:48:40 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:48:40 INFO - Return code: 0 19:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:40 INFO - https://queue.taskcluster.net/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/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:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/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:48:42 INFO - Downloaded 56641354 bytes. 19:48:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:48:42 INFO - mkdir: /builds/slave/test-pgo/properties 19:48:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:48:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:48:42 INFO - Contents: 19:48:42 INFO - build_url:https://queue.taskcluster.net/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:48:43 INFO - Running post-action listener: _resource_record_post_action 19:48:43 INFO - Running post-action listener: set_extra_try_arguments 19:48:43 INFO - ##### 19:48:43 INFO - ##### Running populate-webroot step. 19:48:43 INFO - ##### 19:48:43 INFO - Running pre-action listener: _resource_record_pre_action 19:48:43 INFO - Running main action method: populate_webroot 19:48:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:48:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:48:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:48:43 INFO - '--tppagecycles', 19:48:43 INFO - '7'], 19:48:43 INFO - 'tests': ['tsvgm']}}, 19:48:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:48:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:48:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:48:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:48:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:48:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:48:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:48:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:43 INFO - 'talos_options': ['--e10s'], 19:48:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:48:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:43 INFO - 'tests': ['damp', 'tps']}, 19:48:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:43 INFO - 'talos_options': ['--e10s'], 19:48:43 INFO - 'tests': ['damp', 'tps']}, 19:48:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:48:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:48:43 INFO - 'other': {'tests': ['a11yr', 19:48:43 INFO - 'ts_paint', 19:48:43 INFO - 'tpaint', 19:48:43 INFO - 'sessionrestore', 19:48:43 INFO - 'sessionrestore_no_auto_restore']}, 19:48:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:48:43 INFO - 'tests': ['a11yr', 19:48:43 INFO - 'ts_paint', 19:48:43 INFO - 'tpaint', 19:48:43 INFO - 'sessionrestore', 19:48:43 INFO - 'sessionrestore_no_auto_restore']}, 19:48:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:48:43 INFO - 'tests': ['a11yr', 19:48:43 INFO - 'ts_paint', 19:48:43 INFO - 'tpaint', 19:48:43 INFO - 'sessionrestore', 19:48:43 INFO - 'sessionrestore_no_auto_restore']}, 19:48:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:48:43 INFO - 'tests': ['a11yr', 19:48:43 INFO - 'ts_paint', 19:48:43 INFO - 'tpaint', 19:48:43 INFO - 'sessionrestore', 19:48:43 INFO - 'sessionrestore_no_auto_restore']}, 19:48:43 INFO - 'other_l64': {'tests': ['a11yr', 19:48:43 INFO - 'ts_paint', 19:48:43 INFO - 'tpaint', 19:48:43 INFO - 'sessionrestore', 19:48:43 INFO - 'sessionrestore_no_auto_restore']}, 19:48:43 INFO - 'other_nol64': {'tests': ['a11yr', 19:48:43 INFO - 'ts_paint', 19:48:43 INFO - 'tpaint', 19:48:43 INFO - 'sessionrestore', 19:48:43 INFO - 'sessionrestore_no_auto_restore']}, 19:48:43 INFO - 'svgr': {'tests': ['tsvgx', 19:48:43 INFO - 'tsvgr_opacity', 19:48:43 INFO - 'tart', 19:48:43 INFO - 'tscrollx', 19:48:43 INFO - 'cart']}, 19:48:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:48:43 INFO - 'tests': ['tsvgx', 19:48:43 INFO - 'tsvgr_opacity', 19:48:43 INFO - 'tart', 19:48:43 INFO - 'tscrollx', 19:48:43 INFO - 'cart']}, 19:48:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:43 INFO - 'tests': ['tp5o']}, 19:48:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:43 INFO - 'talos_options': ['--e10s'], 19:48:43 INFO - 'tests': ['tp5o']}, 19:48:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:43 INFO - 'talos_options': ['--xperf_path', 19:48:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:48:43 INFO - 'tests': ['tp5n']}, 19:48:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:43 INFO - 'talos_options': ['--e10s', 19:48:43 INFO - '--xperf_path', 19:48:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:48:43 INFO - 'tests': ['tp5n']}}, 19:48:43 INFO - 'talos.zip': {'path': '', 19:48:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:48:43 INFO - Running post-action listener: _resource_record_post_action 19:48:43 INFO - ##### 19:48:43 INFO - ##### Running create-virtualenv step. 19:48:43 INFO - ##### 19:48:43 INFO - Running pre-action listener: _resource_record_pre_action 19:48:43 INFO - Running main action method: create_virtualenv 19:48:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:48:43 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:48:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:48:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:48:43 INFO - Using real prefix '/usr' 19:48:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:48:43 INFO - Installing distribute.............................................................................................................................................................................................done. 19:48:45 INFO - Installing pip.................done. 19:48:45 INFO - Return code: 0 19:48:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:45 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 0x7f30fa9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8c0>, '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 0x23fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fbc50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', '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:48:45 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:48:45 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:48:45 INFO - Using env: {'DISPLAY': ':0', 19:48:45 INFO - 'HOME': '/home/cltbld', 19:48:45 INFO - 'LANG': 'en_US.UTF-8', 19:48:45 INFO - 'LANGUAGE': 'en_US:en', 19:48:45 INFO - 'LOGNAME': 'cltbld', 19:48:45 INFO - 'MAIL': '/var/mail/cltbld', 19:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:45 INFO - 'MOZ_NO_REMOTE': '1', 19:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:45 INFO - 'NO_EM_RESTART': '1', 19:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:45 INFO - 'SHELL': '/bin/bash', 19:48:45 INFO - 'SHLVL': '1', 19:48:45 INFO - 'TERM': 'linux', 19:48:45 INFO - 'TMOUT': '86400', 19:48:45 INFO - 'USER': 'cltbld', 19:48:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', 19:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:45 INFO - '_': '/tools/buildbot/bin/python'} 19:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:45 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:48:45 INFO - Cleaning up... 19:48:45 INFO - Return code: 0 19:48:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:45 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 0x7f30fa9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8c0>, '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 0x23fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fbc50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', '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:48:45 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:48:45 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:48:45 INFO - Using env: {'DISPLAY': ':0', 19:48:45 INFO - 'HOME': '/home/cltbld', 19:48:45 INFO - 'LANG': 'en_US.UTF-8', 19:48:45 INFO - 'LANGUAGE': 'en_US:en', 19:48:45 INFO - 'LOGNAME': 'cltbld', 19:48:45 INFO - 'MAIL': '/var/mail/cltbld', 19:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:45 INFO - 'MOZ_NO_REMOTE': '1', 19:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:45 INFO - 'NO_EM_RESTART': '1', 19:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:45 INFO - 'SHELL': '/bin/bash', 19:48:45 INFO - 'SHLVL': '1', 19:48:45 INFO - 'TERM': 'linux', 19:48:45 INFO - 'TMOUT': '86400', 19:48:45 INFO - 'USER': 'cltbld', 19:48:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', 19:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:45 INFO - '_': '/tools/buildbot/bin/python'} 19:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:46 INFO - Downloading/unpacking psutil>=0.7.1 19:48: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:48: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:48: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:48: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:48: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:48: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:48:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:48:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:48:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:48:47 INFO - Installing collected packages: psutil 19:48:47 INFO - Running setup.py install for psutil 19:48:48 INFO - building 'psutil._psutil_linux' extension 19:48:48 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:48:48 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:48:48 INFO - building 'psutil._psutil_posix' extension 19:48:48 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:48:48 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:48:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:48:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:48:48 INFO - Successfully installed psutil 19:48:48 INFO - Cleaning up... 19:48:48 INFO - Return code: 0 19:48:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:48 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 0x7f30fa9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8c0>, '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 0x23fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fbc50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', '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:48:48 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:48:48 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:48:48 INFO - Using env: {'DISPLAY': ':0', 19:48:48 INFO - 'HOME': '/home/cltbld', 19:48:48 INFO - 'LANG': 'en_US.UTF-8', 19:48:48 INFO - 'LANGUAGE': 'en_US:en', 19:48:48 INFO - 'LOGNAME': 'cltbld', 19:48:48 INFO - 'MAIL': '/var/mail/cltbld', 19:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:48 INFO - 'MOZ_NO_REMOTE': '1', 19:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:48 INFO - 'NO_EM_RESTART': '1', 19:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:48 INFO - 'SHELL': '/bin/bash', 19:48:48 INFO - 'SHLVL': '1', 19:48:48 INFO - 'TERM': 'linux', 19:48:48 INFO - 'TMOUT': '86400', 19:48:48 INFO - 'USER': 'cltbld', 19:48:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', 19:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:48 INFO - '_': '/tools/buildbot/bin/python'} 19:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:48: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:48: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:48: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:48: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:48: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:48: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:48:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:48:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:48:50 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:48:50 INFO - Installing collected packages: mozsystemmonitor 19:48:50 INFO - Running setup.py install for mozsystemmonitor 19:48:50 INFO - Successfully installed mozsystemmonitor 19:48:50 INFO - Cleaning up... 19:48:50 INFO - Return code: 0 19:48:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:50 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 0x7f30fa9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8c0>, '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 0x23fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fbc50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', '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:48:50 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:48:50 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:48:50 INFO - Using env: {'DISPLAY': ':0', 19:48:50 INFO - 'HOME': '/home/cltbld', 19:48:50 INFO - 'LANG': 'en_US.UTF-8', 19:48:50 INFO - 'LANGUAGE': 'en_US:en', 19:48:50 INFO - 'LOGNAME': 'cltbld', 19:48:50 INFO - 'MAIL': '/var/mail/cltbld', 19:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:50 INFO - 'MOZ_NO_REMOTE': '1', 19:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:50 INFO - 'NO_EM_RESTART': '1', 19:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:50 INFO - 'SHELL': '/bin/bash', 19:48:50 INFO - 'SHLVL': '1', 19:48:50 INFO - 'TERM': 'linux', 19:48:50 INFO - 'TMOUT': '86400', 19:48:50 INFO - 'USER': 'cltbld', 19:48:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', 19:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:50 INFO - '_': '/tools/buildbot/bin/python'} 19:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:50 INFO - Downloading/unpacking blobuploader==1.2.4 19:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:52 INFO - Downloading blobuploader-1.2.4.tar.gz 19:48:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:48:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:48:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:48:53 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:48:53 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:48:53 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:48:53 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:48:53 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:48:53 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:48:53 INFO - Downloading docopt-0.6.1.tar.gz 19:48:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:48:53 INFO - Installing collected packages: blobuploader, requests, docopt 19:48:53 INFO - Running setup.py install for blobuploader 19:48:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:48:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:48:53 INFO - Running setup.py install for requests 19:48:53 INFO - Running setup.py install for docopt 19:48:54 INFO - Successfully installed blobuploader requests docopt 19:48:54 INFO - Cleaning up... 19:48:54 INFO - Return code: 0 19:48:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:54 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 0x7f30fa9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8c0>, '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 0x23fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fbc50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', '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:48:54 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:48:54 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:48:54 INFO - Using env: {'DISPLAY': ':0', 19:48:54 INFO - 'HOME': '/home/cltbld', 19:48:54 INFO - 'LANG': 'en_US.UTF-8', 19:48:54 INFO - 'LANGUAGE': 'en_US:en', 19:48:54 INFO - 'LOGNAME': 'cltbld', 19:48:54 INFO - 'MAIL': '/var/mail/cltbld', 19:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:54 INFO - 'MOZ_NO_REMOTE': '1', 19:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:54 INFO - 'NO_EM_RESTART': '1', 19:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:54 INFO - 'SHELL': '/bin/bash', 19:48:54 INFO - 'SHLVL': '1', 19:48:54 INFO - 'TERM': 'linux', 19:48:54 INFO - 'TMOUT': '86400', 19:48:54 INFO - 'USER': 'cltbld', 19:48:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', 19:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:54 INFO - '_': '/tools/buildbot/bin/python'} 19:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:48:54 INFO - Running setup.py (path:/tmp/pip-ZOw_XK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:48:54 INFO - Running setup.py (path:/tmp/pip-i6QDf5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:48:54 INFO - Running setup.py (path:/tmp/pip-T6citI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:48:54 INFO - Running setup.py (path:/tmp/pip-drJ0z5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:48:54 INFO - Running setup.py (path:/tmp/pip-mssntE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:48:54 INFO - Running setup.py (path:/tmp/pip-TTqwYd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:48:54 INFO - Running setup.py (path:/tmp/pip-IYbU64-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:48:54 INFO - Running setup.py (path:/tmp/pip-1FhSCf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:48:54 INFO - Running setup.py (path:/tmp/pip-IA5qyy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:48:54 INFO - Running setup.py (path:/tmp/pip-MpzTAG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:48:55 INFO - Running setup.py (path:/tmp/pip-IAYVFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:48:55 INFO - Running setup.py (path:/tmp/pip-JnF72W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:48:55 INFO - Running setup.py (path:/tmp/pip-hv0Bsv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:48:55 INFO - Running setup.py (path:/tmp/pip-wHFRoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:48:55 INFO - Running setup.py (path:/tmp/pip-kDeR85-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:48:55 INFO - Running setup.py (path:/tmp/pip-WlbyrI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:48:55 INFO - Running setup.py (path:/tmp/pip-i1weAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:48:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:48:55 INFO - Running setup.py install for manifestparser 19:48:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:48:55 INFO - Running setup.py install for mozcrash 19:48:55 INFO - Running setup.py install for mozdebug 19:48:55 INFO - Running setup.py install for mozdevice 19:48:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:48:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:48:55 INFO - Running setup.py install for mozfile 19:48:56 INFO - Running setup.py install for mozhttpd 19:48:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Running setup.py install for mozinfo 19:48:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Running setup.py install for mozInstall 19:48:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Running setup.py install for mozleak 19:48:56 INFO - Running setup.py install for mozlog 19:48:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Running setup.py install for moznetwork 19:48:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Running setup.py install for mozprocess 19:48:56 INFO - Running setup.py install for mozprofile 19:48:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Running setup.py install for mozrunner 19:48:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:48:56 INFO - Running setup.py install for mozscreenshot 19:48:57 INFO - Running setup.py install for moztest 19:48:57 INFO - Running setup.py install for mozversion 19:48:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:48:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:48:57 INFO - Cleaning up... 19:48:57 INFO - Return code: 0 19:48:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:57 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 0x7f30fa9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8c0>, '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 0x23fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fbc50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', '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:48:57 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:48:57 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:48:57 INFO - Using env: {'DISPLAY': ':0', 19:48:57 INFO - 'HOME': '/home/cltbld', 19:48:57 INFO - 'LANG': 'en_US.UTF-8', 19:48:57 INFO - 'LANGUAGE': 'en_US:en', 19:48:57 INFO - 'LOGNAME': 'cltbld', 19:48:57 INFO - 'MAIL': '/var/mail/cltbld', 19:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:57 INFO - 'MOZ_NO_REMOTE': '1', 19:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:57 INFO - 'NO_EM_RESTART': '1', 19:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:57 INFO - 'SHELL': '/bin/bash', 19:48:57 INFO - 'SHLVL': '1', 19:48:57 INFO - 'TERM': 'linux', 19:48:57 INFO - 'TMOUT': '86400', 19:48:57 INFO - 'USER': 'cltbld', 19:48:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', 19:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:57 INFO - '_': '/tools/buildbot/bin/python'} 19:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:48:57 INFO - Running setup.py (path:/tmp/pip-L9o9Zi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:48:57 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:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:48:57 INFO - Running setup.py (path:/tmp/pip-HBURA_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:48:57 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:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:48:57 INFO - Running setup.py (path:/tmp/pip-iAVkJx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:48:57 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:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:48:57 INFO - Running setup.py (path:/tmp/pip-rXka53-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:48:57 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:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:48:57 INFO - Running setup.py (path:/tmp/pip-RHeN2i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:48:57 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:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:48:57 INFO - Running setup.py (path:/tmp/pip-1Iint2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:48:57 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:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:48:57 INFO - Running setup.py (path:/tmp/pip-ot6goj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:48:58 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:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:48:58 INFO - Running setup.py (path:/tmp/pip-avfP_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:48:58 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:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:48:58 INFO - Running setup.py (path:/tmp/pip-eEmP2i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:48:58 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:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:48:58 INFO - Running setup.py (path:/tmp/pip-LQo6pn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:48:58 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:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:48:58 INFO - Running setup.py (path:/tmp/pip-wbUN4W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:48:58 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:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:48:58 INFO - Running setup.py (path:/tmp/pip-SH2rl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:48:58 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:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:48:58 INFO - Running setup.py (path:/tmp/pip-htZnes-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:48:58 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:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:48:58 INFO - Running setup.py (path:/tmp/pip-I0k9Z4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:48:58 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:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:48:58 INFO - Running setup.py (path:/tmp/pip-x5KyhD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:48:58 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:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:48:58 INFO - Running setup.py (path:/tmp/pip-sqpFmx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:48:58 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:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:48:58 INFO - Running setup.py (path:/tmp/pip-i3EvU7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:48:58 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:48:58 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:48:58 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:48:58 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:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:48:58 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:48:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:00 INFO - Downloading blessings-1.6.tar.gz 19:49:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:49:00 INFO - Installing collected packages: blessings 19:49:00 INFO - Running setup.py install for blessings 19:49:00 INFO - Successfully installed blessings 19:49:00 INFO - Cleaning up... 19:49:00 INFO - Return code: 0 19:49:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:49:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:49:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:49:01 INFO - Reading from file tmpfile_stdout 19:49:01 INFO - Current package versions: 19:49:01 INFO - argparse == 1.2.1 19:49:01 INFO - blessings == 1.6 19:49:01 INFO - blobuploader == 1.2.4 19:49:01 INFO - docopt == 0.6.1 19:49:01 INFO - manifestparser == 1.1 19:49:01 INFO - mozInstall == 1.12 19:49:01 INFO - mozcrash == 0.16 19:49:01 INFO - mozdebug == 0.1 19:49:01 INFO - mozdevice == 0.48 19:49:01 INFO - mozfile == 1.2 19:49:01 INFO - mozhttpd == 0.7 19:49:01 INFO - mozinfo == 0.9 19:49:01 INFO - mozleak == 0.1 19:49:01 INFO - mozlog == 3.1 19:49:01 INFO - moznetwork == 0.27 19:49:01 INFO - mozprocess == 0.22 19:49:01 INFO - mozprofile == 0.28 19:49:01 INFO - mozrunner == 6.11 19:49:01 INFO - mozscreenshot == 0.1 19:49:01 INFO - mozsystemmonitor == 0.0 19:49:01 INFO - moztest == 0.7 19:49:01 INFO - mozversion == 1.4 19:49:01 INFO - psutil == 3.1.1 19:49:01 INFO - requests == 1.2.3 19:49:01 INFO - wsgiref == 0.1.2 19:49:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:01 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 0x7f30fa9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8c0>, '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 0x23fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fbc50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', '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:49:01 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:49:01 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:49:01 INFO - Using env: {'DISPLAY': ':0', 19:49:01 INFO - 'HOME': '/home/cltbld', 19:49:01 INFO - 'LANG': 'en_US.UTF-8', 19:49:01 INFO - 'LANGUAGE': 'en_US:en', 19:49:01 INFO - 'LOGNAME': 'cltbld', 19:49:01 INFO - 'MAIL': '/var/mail/cltbld', 19:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:01 INFO - 'MOZ_NO_REMOTE': '1', 19:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:01 INFO - 'NO_EM_RESTART': '1', 19:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:01 INFO - 'SHELL': '/bin/bash', 19:49:01 INFO - 'SHLVL': '1', 19:49:01 INFO - 'TERM': 'linux', 19:49:01 INFO - 'TMOUT': '86400', 19:49:01 INFO - 'USER': 'cltbld', 19:49:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', 19:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:01 INFO - '_': '/tools/buildbot/bin/python'} 19:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:01 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:49:01 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:49:01 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:49:01 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:49:01 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:49:01 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:49:01 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:49:01 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:49:01 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:49:01 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:49:01 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:49:01 INFO - Cleaning up... 19:49:01 INFO - Return code: 0 19:49:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:01 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 0x7f30fa9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8c0>, '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 0x23fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fbc50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', '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:49:01 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:49:01 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:49:01 INFO - Using env: {'DISPLAY': ':0', 19:49:01 INFO - 'HOME': '/home/cltbld', 19:49:01 INFO - 'LANG': 'en_US.UTF-8', 19:49:01 INFO - 'LANGUAGE': 'en_US:en', 19:49:01 INFO - 'LOGNAME': 'cltbld', 19:49:01 INFO - 'MAIL': '/var/mail/cltbld', 19:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:01 INFO - 'MOZ_NO_REMOTE': '1', 19:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:01 INFO - 'NO_EM_RESTART': '1', 19:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:01 INFO - 'SHELL': '/bin/bash', 19:49:01 INFO - 'SHLVL': '1', 19:49:01 INFO - 'TERM': 'linux', 19:49:01 INFO - 'TMOUT': '86400', 19:49:01 INFO - 'USER': 'cltbld', 19:49:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', 19:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:01 INFO - '_': '/tools/buildbot/bin/python'} 19:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:01 INFO - Downloading/unpacking jsonschema 19:49: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:49: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:49: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:49: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:49: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:49: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:49:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:49:03 INFO - Downloading/unpacking functools32 (from jsonschema) 19:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:03 INFO - Downloading functools32-3.2.3-2.tar.gz 19:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:49:03 INFO - warning: no files found matching '*.txt' 19:49:03 INFO - no previously-included directories found matching 'build' 19:49:03 INFO - no previously-included directories found matching 'dist' 19:49:03 INFO - no previously-included directories found matching '.git*' 19:49:03 INFO - Installing collected packages: jsonschema, functools32 19:49:03 INFO - Running setup.py install for functools32 19:49:04 INFO - warning: no files found matching '*.txt' 19:49:04 INFO - no previously-included directories found matching 'build' 19:49:04 INFO - no previously-included directories found matching 'dist' 19:49:04 INFO - no previously-included directories found matching '.git*' 19:49:04 INFO - Successfully installed jsonschema functools32 19:49:04 INFO - Cleaning up... 19:49:04 INFO - Return code: 0 19:49:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:49:04 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:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:04 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:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:04 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 0x7f30fa9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa8c0>, '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 0x23fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fbc50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', '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:49:04 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:49:04 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:49:04 INFO - Using env: {'DISPLAY': ':0', 19:49:04 INFO - 'HOME': '/home/cltbld', 19:49:04 INFO - 'LANG': 'en_US.UTF-8', 19:49:04 INFO - 'LANGUAGE': 'en_US:en', 19:49:04 INFO - 'LOGNAME': 'cltbld', 19:49:04 INFO - 'MAIL': '/var/mail/cltbld', 19:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:04 INFO - 'MOZ_NO_REMOTE': '1', 19:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:04 INFO - 'NO_EM_RESTART': '1', 19:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:04 INFO - 'SHELL': '/bin/bash', 19:49:04 INFO - 'SHLVL': '1', 19:49:04 INFO - 'TERM': 'linux', 19:49:04 INFO - 'TMOUT': '86400', 19:49:04 INFO - 'USER': 'cltbld', 19:49:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', 19:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:04 INFO - '_': '/tools/buildbot/bin/python'} 19:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:04 INFO - Downloading/unpacking flake8 19:49:04 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:49:04 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:49:04 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:49:04 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:49:04 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:49:04 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:49:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:49:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:49:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:49:06 INFO - no previously-included directories found matching 'docs/_build' 19:49:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:49:06 INFO - Running setup.py install for pep8 19:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:49:06 INFO - no previously-included directories found matching 'docs/_build' 19:49:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:49:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:49:07 INFO - Cleaning up... 19:49:07 INFO - Return code: 0 19:49:07 INFO - Running post-action listener: _resource_record_post_action 19:49:07 INFO - Running post-action listener: _start_resource_monitoring 19:49:07 INFO - Starting resource monitoring. 19:49:07 INFO - ##### 19:49:07 INFO - ##### Running install step. 19:49:07 INFO - ##### 19:49:07 INFO - Running pre-action listener: _resource_record_pre_action 19:49:07 INFO - Running main action method: install 19:49:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:49:07 INFO - Reading from file tmpfile_stdout 19:49:07 INFO - Detecting whether we're running mozinstall >=1.0... 19:49:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:49:07 INFO - Reading from file tmpfile_stdout 19:49:07 INFO - Output received: 19:49:07 INFO - Usage: mozinstall [options] installer 19:49:07 INFO - Options: 19:49:07 INFO - -h, --help show this help message and exit 19:49:07 INFO - -d DEST, --destination=DEST 19:49:07 INFO - Directory to install application into. [default: 19:49:07 INFO - "/builds/slave/test-pgo"] 19:49:07 INFO - --app=APP Application being installed. [default: firefox] 19:49:07 INFO - mkdir: /builds/slave/test-pgo/build/application 19:49:07 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:49:07 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:49:23 INFO - Reading from file tmpfile_stdout 19:49:23 INFO - Output received: 19:49:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:49:26 INFO - Running post-action listener: _resource_record_post_action 19:49:26 INFO - ##### 19:49:26 INFO - ##### Running run-tests step. 19:49:26 INFO - ##### 19:49:26 INFO - Running pre-action listener: _resource_record_pre_action 19:49:26 INFO - Running main action method: run_tests 19:49:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:49:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:49:26 INFO - Python 2.7.3 19:49:26 INFO - Return code: 0 19:49:26 INFO - grabbing minidump binary from tooltool 19:49:26 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:49:26 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 0x23fa8c0>, '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 0x23fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fbc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:49:26 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:49:26 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:49:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:49:27 INFO - Return code: 0 19:49:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:49:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:49:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:49:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:49:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:49:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:49:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:49:28 INFO - Return code: 0 19:49:28 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/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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:49:28 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/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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:49:28 INFO - Using env: {'DISPLAY': ':0', 19:49:28 INFO - 'HOME': '/home/cltbld', 19:49:28 INFO - 'LANG': 'en_US.UTF-8', 19:49:28 INFO - 'LANGUAGE': 'en_US:en', 19:49:28 INFO - 'LOGNAME': 'cltbld', 19:49:28 INFO - 'MAIL': '/var/mail/cltbld', 19:49:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:49:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:28 INFO - 'MOZ_NO_REMOTE': '1', 19:49:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:28 INFO - 'NO_EM_RESTART': '1', 19:49:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:28 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:49:28 INFO - 'SHELL': '/bin/bash', 19:49:28 INFO - 'SHLVL': '1', 19:49:28 INFO - 'TERM': 'linux', 19:49:28 INFO - 'TMOUT': '86400', 19:49:28 INFO - 'USER': 'cltbld', 19:49:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313', 19:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:28 INFO - '_': '/tools/buildbot/bin/python'} 19:49:28 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/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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:49:28 INFO - mozversion application_buildid: 20160229173007 19:49:28 INFO - mozversion application_changeset: 1b2fddb62fcc4d1038f2e57b619a56c4f1837507 19:49:28 INFO - mozversion application_display_name: Nightly 19:49:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:49:28 INFO - mozversion application_name: Firefox 19:49:28 INFO - mozversion application_remotingname: firefox 19:49:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:49:28 INFO - mozversion application_vendor: Mozilla 19:49:28 INFO - mozversion application_version: 47.0a1 19:49:28 INFO - mozversion platform_buildid: 20160229173007 19:49:28 INFO - mozversion platform_changeset: 1b2fddb62fcc4d1038f2e57b619a56c4f1837507 19:49:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:49:28 INFO - mozversion platform_version: 47.0a1 19:49:28 INFO - using testdate: 1456804168 19:49:28 INFO - actual date: 1456804168 19:49:28 INFO - starting webserver on 'localhost:50133' 19:49:28 INFO - SUITE-START | Running 2 tests 19:49:28 INFO - TEST-START | dromaeo_css 19:49:28 INFO - operating with platform_type : linux_ 19:49:28 INFO - Initialising browser for dromaeo_css test... 19:49:28 INFO - TEST-INFO | started process 6147 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpokrKjp/profile http://localhost:50133/getInfo.html) 19:49:43 INFO - PROCESS | 6147 | 19:49:43 INFO - PROCESS | 6147 | (process:6232): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:49:46 INFO - PROCESS | 6147 | __metrics Screen width/height:1600/1200 19:49:46 INFO - PROCESS | 6147 | colorDepth:24 19:49:46 INFO - PROCESS | 6147 | Browser inner width/height: 1024/697 19:49:46 INFO - PROCESS | 6147 | __metrics 19:50:35 ERROR - PROCESS | 6147 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:50:35 INFO - PROCESS | 6147 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:50:35 INFO - PROCESS | 6147 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:50:35 INFO - PROCESS | 6147 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:50:35 INFO - PROCESS | 6147 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:50:35 INFO - PROCESS | 6147 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:50:35 INFO - PROCESS | 6147 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:50:35 INFO - PROCESS | 6147 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:50:35 INFO - PROCESS | 6147 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:50:35 INFO - PROCESS | 6147 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:50:36 INFO - TEST-INFO | 6147: exit 0 19:50:36 INFO - Browser initialized. 19:50:36 INFO - Running cycle 1/1 for dromaeo_css test... 19:50:36 INFO - TEST-INFO | started process 6289 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpokrKjp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:37 INFO - PROCESS | 6289 | 19:50:37 INFO - PROCESS | 6289 | (process:6348): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:50:48 INFO - PROCESS | 6289 | RSS: Main: 159989760 19:50:48 INFO - PROCESS | 6289 | 19:51:38 INFO - PROCESS | 6289 | 1456804298035 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:53:46 INFO - PROCESS | 6289 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50133/tests/dromaeo/cssquery-ext.html) 19:53:47 INFO - PROCESS | 6289 | RSS: Main: 170315776 19:53:47 INFO - PROCESS | 6289 | 19:56:49 INFO - PROCESS | 6289 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-ext.html (next: http://localhost:50133/tests/dromaeo/cssquery-jquery.html) 19:56:50 INFO - PROCESS | 6289 | RSS: Main: 165146624 19:56:50 INFO - PROCESS | 6289 | 19:59:52 INFO - PROCESS | 6289 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50133/tests/dromaeo/cssquery-mootools.html) 19:59:52 INFO - PROCESS | 6289 | RSS: Main: 164884480 19:59:52 INFO - PROCESS | 6289 | 20:02:54 INFO - PROCESS | 6289 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50133/tests/dromaeo/cssquery-prototype.html) 20:02:55 INFO - PROCESS | 6289 | RSS: Main: 164487168 20:02:55 INFO - PROCESS | 6289 | 20:05:57 INFO - PROCESS | 6289 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50133/tests/dromaeo/cssquery-yui.html) 20:05:58 INFO - PROCESS | 6289 | RSS: Main: 164372480 20:05:58 INFO - PROCESS | 6289 | 20:09:00 INFO - PROCESS | 6289 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-yui.html (next: http://localhost:50133/tests/dromaeo/cssquery-dojo.html) 20:09:00 INFO - PROCESS | 6289 | RSS: Main: 168873984 20:09:00 INFO - PROCESS | 6289 | 20:09:00 INFO - PROCESS | 6289 | __start_tp_report 20:09:00 INFO - PROCESS | 6289 | _x_x_mozilla_page_load 20:09:00 INFO - PROCESS | 6289 | _x_x_mozilla_page_load_details 20:09:00 INFO - PROCESS | 6289 | |i|pagename|runs| 20:09:00 INFO - PROCESS | 6289 | |0;dojo.html;3207.9839600801997;3229.0312906128156;3258;3271.2149084219777;3279.83600819959;5201.739913004353;5292.153255479124;5331.333583302087;5334.706591137486;5341;5182.144946083891;5201.661891977028;5212.947870521293;5263.499967503081;5267;4786.353842231289;4834.3473631059705;4923.483034281403;4964.726940018298;4994.475580064095;4717.457492388367;4764.309175169598;4878.829240976566;4900.387451568554;4902.754862256891;4779.16364636189;4795.928061079087;4816.9999999999645;4822.276658501218;4858.149823780825;4813.566778989908;4820.8071677132875;4820.831270905502;4834.6374021948495;4859.028194361106;4801.615870730333;4809.278608208761;4812.989272252831;4852.005338905516;4891.926621100686;5026.421961474441;5129.102407078746;5153.046686362997;5172.379314482287;5176.912848301861;5671.631343962629;5673.546116310686;5681.602287839853;5696.857578560528;5722.7424765885635;5537.861553461155;5638.859028524279;5640.943590564083;5688.800891968803;5714.257146570961;5347.010803001457;5351.036813373591;5359.356877174725;5363.785448582091;5380.192971054373;5662.235598194191;5836.795712150054;5840.94159058404;5841.707914604252;5855.707214639251;5540.861478463071;5548.55611551083;5583.330000399978;5586.91619625706;5609.691466969274;5562.888742225133;5655.123455864347;5719.885602287931;5729.28383952006;5741.311042674823;5615.185798059259;5682.886342273214;5689.231953686282;5696.857578560569;5707.3721890592005;5565.805196818092;5628.296462942132;5638.548916086703;5643.661380317194;5692.8861422771315;4293.355996600535;4323.718958267703;4334.869953901388;4338.869833904988;4372;3865.729398942103;3868.883933482;3911.3741801311653;3918.0792513759243;3918.941215881764;5363.865903352447;5396.217548455452;5414.242006119146;5421.728913554307;5464.617476776667;5652.123920792284;5680.5455563554815;5705.82882513517;5707.543396528268;5709.371969083398;5285.867853303698;5412.729363531807;5418.620696551282;5452.727363631802;5466.125419932791;4677.6257899367965;4702.106599746037;4712.387389639393;4747.596454301354;4771.928421073687;5751.396103409165;5804.4775970162045;5811.4479124483105;5815.127730840408;5838.737256823369;5497.47773961473;5576.191452239322;5584.246126772834;5599.440055994368;5679.659220446786;5770.567207459541;5778.797742079007;5787.160861675117;5789.015867302484;5839.883202336015;5435.456454354533;5440.047991601533;5441;5441.238226648194;5466.726663666721;5536.363318218457;5570.053090974463;5579.246801681721;5617.522510586646;5647.7176141193595;5385.488378604026;5439.891202176013;5449.155380915964;5465.453454654503;5504.366997795305;5455.618106732491;5538.390777014444;5540.196671482532;5545.417731138334;5554.444555544414;5391.919121213106;5430.945690543044;5494.450554944474;5517.944820551904;5569.777208911761;5561.6663000220115;5567.526760225426;5572.275604171432;5607.747651355618;5611.6352437091455;5474.835754927359;5483.7258137092185;5486.094794358886;5495.313085864267;5535.446455354593 20:09:00 INFO - PROCESS | 6289 | |1;ext.html;507.0543436490944;508.73037290236164;531.4021725558746;534.156033467122;556.6409665765582;36944.07639809006;37076.25847483049;37253.62746372535;37407.25185496295;37493.62506374936;40546.79726601363;40834.38748418776;40967.79516102423;41130;41186.17627647445;8403.57982100894;8609.225169734722;8662.17709317617;8689.869651955225;8700.216980471756;8344.624491897848;8451.492910425393;8454.154584541528;8463.534505602189;8464.915350846504;8713.477191368538;8825.955870220672;8838.734837954871;8843.734687959339;8874.467531948103;8705.216530512253;8773.429727067753;8805.955970220171;8846.646134154595;8851.955740221258;8575.399722019461;8759;8770.780730481725;8772.561371931442;8781.692640757543;40096;40492;40527.7973610133;40569.594304056875;40604.79697601523;2835.7829324369527;3191.1020224943313;3241.918952026218;3413.9146521337166;3497.422925217336;27162;27529.44941101167;28050.859745701346;28447;28761;3885.9805700971597;3898.902527436808;3908.882733517999;3985.561588225293;4015.8393664253394;260618;263807;264003;264941;265519;41266.79366603148;41906.790466048085;61821;62544.68727656423;62599.6870015647;40517.797411012754;40591;40591.79704101461;40748.79625601853;40934.59065409367;12904.935475322563;12933.417996190194;12990.545330913561;13016.934915325552;13061.673458163432;10124.949375253076;10126.291159618904;10168;10185.9490702546;10208.6426975057;13894.166350019032;14311.642208944651;14333.64165895861;14385.136891786526;14428.783568246485;5743.277016894915;5756.3380211276235;5833.358330583633;5867.501262392659;5875.707344384228;976.2775546095838;1024.4365598920565;1030.1038096855784;1035.0684384054412;1051.9368837869752;28586.428271434455;28752.281192970342;28901.56647650287;28916.7108328914;29218.415631687247;1085.6580177244143;1146.690393593725;1173.4426147579832;1176.0767797279095;1180.996153269731;15025.924870375578;15150.31823567942;15194.772078418833;15325.9233703833;15415.537533874001;292853;443230;446875;447290;449202;50890.74554627203;51175.23237151446;51381.743091284305;51530;51729;1338.2372047932586;1350.0414705558967;1358.4498278197345;1363.604554679132;1364.590622813152;27350.72649273482;28356.71643283541;28865.85567072151;28933.276668083465;28982.27544311409;46441;46930.76534617442;47056;47243;47340.52659473361;279062;287587;287774.56112719304;288011;288516;31407.21481962969;31444;31678.683213167573;31769.20576985594;31883;42966.78516607522;43329.35005974976;43713.12573748571;44304.556954430045;44324;35286.17980448167;35748;36129;36961.44557831688;37486.43770343502;36564.451533227555;36637.450438242915;37190.8140459296;37245;37640.81179594085;35735.46396804102;36488.81755591205;36646.26707465889;36894.63105368912;37182;31287.530687039256;33419.83290083534;33943.3211335767;34239;34425;24890.626640600043;25589.872050639628;25696.354840159256;25795.097171598904;25837.612435813102 20:09:00 INFO - PROCESS | 6289 | |2;jquery.html;341.34121146187846;346.3091133189287;349.74818130945727;350.38157651744666;350.8719317449132;16164.75752863708;16455.34178632856;16787.748183777254;17125.82874171258;17219.569510762238;15012.099274043565;15017.62455938602;15869.92065039676;16241.83758162418;16291.348346066172;4700.459447163577;5180.507851754077;5329.520343169114;5375.838724838261;5419.051665958461;5206.088934436478;5324.41431442541;5330.733463326837;5355.3305836770405;5359.196120581905;5094.363204599425;5295.205719142121;5297.337832770903;5298.1522956327;5302.965921645281;5246.029484545371;5265.394479634814;5285.339332583427;5296.867578310554;5307.310049693534;4622;4652.441706995149;4672.719636821802;4681.1105889881155;4683.578477937002;20048.097835597433;20261.39215823513;20698.5860282795;20717.792822071737;20943.476413089644;2173.7717539658265;2235.58641651295;2286.074139973297;2301.240590605113;2354.693889794333;8364.456310339869;8749.16882896124;12945.611631651065;13138.802917956238;13489.932550337186;1798.5413719501573;1867.085128287143;1875.456117725858;1937.9224831006743;1966.6263409952064;55395.44604553943;58083.709581451825;61309.38690613037;62611.37388626146;65960.6701966492;9910.256730745223;10095.596176153018;10362.119219866396;10422.687319380431;10538.104261137889;13739.931300343635;13790.379432925542;13795.517156899661;13855.653608659662;13947.651308717363;6843.657817109125;7001.194862590765;7021.859562808715;7131.393831524379;7133.466304744505;6607.669616519155;6699.330066993359;6710.530262881649;6775.0514927910135;6790.287019862843;4438.778061096932;4499.1451624191295;4517.503074661785;4519.5480451954545;4608.677392582487;1771.353455988555;1796.6765982123343;1870.9158087886078;1900.3063881683086;1920.7310976463307;965.7778710896392;974.7904200596905;984.5520288268821;1040.5941682743735;1081.3187691754301;16266.268017939221;16715.498535043967;16938.49184524466;17031.65936681284;17238.913805431144;929.0477260807592;954.575214029764;963.6482683820356;1004.3873237325225;1023.4371095897376;9551.331406801597;9642.228621710246;9645.662401815904;9648.517574121266;9738.119105685042;323155;327696;330181;334493;409171;65583.67208164024;69224;75320;77186;77992.61003695059;975.6292608808608;1007.8034783217349;1009.1523120578603;1011.5296387179997;1030.2324768048002;14423.49517766873;15102.924485377504;15326.616834579225;15401.229938502805;15780.76328855091;33630.327393452484;33845.153871153416;34159.829200853834;34725.652743473256;35148.47277290792;42703.35944960766;45224.32163517616;45422.77288613668;45802;46299.53700462952;7635.580043097683;7686.07767067933;7785.221477852169;7907.723229686933;8000.759977200693;8896.154865287788;11529.942350288195;11766.294022358687;11847.052235821286;12270.447829847857;10323.48382580883;10648.84026739584;10931.945340273247;11043.613473528709;11076.944615276872;10164.847527287244;10632.468376580986;10731.839022414513;10816.242862999514;10962.903709628974;10709.785804283714;10787.838182427427;11059.170562208028;11116;11330.150238731963;7102.041224434635;7415.777526674208;7505.099388073466;7522.661480233293;7527.096748390009;9381.343305968516;10205.132563732166;10516.316439431412;10637.787244255227;10670.253082284165 20:09:00 INFO - PROCESS | 6289 | |3;mootools.html;1481.6147801571592;1500.6773543688105;1671.8161002289746;1772.220223101836;1794.8474379677727;6439.967800160993;7104.893426598605;7229.855402891945;7361.190269070405;7381.557106573603;7254.528455650392;7333.486655934087;7336.449766267525;7403.740869069584;7414.703411863533;2212.6902233687297;2242.8093612042994;2253.830962677806;2257.164849005862;2261.231181398324;2177.433867194533;2192.7807219278025;2236.37381533171;2237.6307909195043;2247.0674670011927;2245.0346351069115;2257.6500642400456;2273.6362182050875;2273.8863056847176;2282.0301371916953;2205.977940220593;2209.5359974405396;2239.6192647249845;2242.7196600424945;2243.091547923094;2205.845590808644;2210.24851550472;2212.4800671842104;2230.8884555772147;2231.2859884836857;7446;7457.067866516685;7465.141508726511;7494;7496.475246732731;4401.603855653007;4447.911041779179;4477.977610111961;4485.2599321111975;4499.932501012488;2933.149386677861;3070.969290307091;3080.753539716817;3093.767967402454;3114.4082624301536;977.2426369563645;986.191323115046;990.8067926754286;1016.2479764973866;1016.9847452288221;9756.707298781048;9796.804063918682;9810.950945245228;9832.950835245849;9848.90151098487;4005.0588111793704;4061.756294622273;4111.773852438145;4132.40080188371;4151.398047283187;8314.708985185489;8331.541765202972;8338.124496927856;8362.038365588036;8391.160883911682;4475.127350166751;4478.037221997221;4483.932741008887;4506.481754598263;4516.23224051912;3683.8710645127294;4023.6177563131455;4042.757434553936;4064.1871625674985;4100.610442008005;3508.1755787389943;3587.4260118381458;3589.766665166756;3595.1191957970464;3641.5266015418356;1151.717829131868;1169.92980421175;1172.4430895324654;1173.4895320535595;1178.452019810775;1302.3618426970716;1317.5783749200355;1321.7686904791624;1370.8903287737157;1371.081375478432;6835.179778426521;6880.105586273752;6998.020277161201;7005.719771209095;7021.613811240329;484.80123149508535;490.52419153421124;492.07735495945104;493.1591636260168;498;5456.972715136399;5468.605505596127;5478.91781623276;5497.202905578749;5546;8601.397902146915;8690.130986901386;8917.286617070618;8939.821203575892;8976.955115224382;8725.389222754346;8822.86765698515;8837.072107428756;8866.290696744245;8953.104689530996;6662.133922590032;6836.077129587442;6846.4522838173825;6920.723171073201;7054.858902821915;6760.425363843931;6765.357291057342;6793.218779840184;6807.047013418224;6819.863602728017;7596.354309883501;7847.293743563107;7851.56816375082;7878.212178782076;7949.483283586548;7841.529508229524;8037.196280371916;8057.798555036171;8071.434999549975;8159.8776018358585;5910.970445147918;6240.875182496416;6338.271098823509;6453.354664533509;6511.34886511345;6884.277150899284;6895.034695142785;6905.792826215222;6913.654317284217;6923.342282483156;6083.452489275986;6147.262328520606;6209.223847019122;6248.500119990299;6309.558330916791;6186.443220110212;6228.22147231596;6288.1825362704385;6316.399942005502;6330.8100756977365;6579.605223686594;6581.045748366556;6588.868222635616;6605.339466053549;6619.3049729779605;6159.384061593984;6159.938400615936;6245.125682404558;6246.656433896179;6250.968745156245;6110.450059494489;6141.07883817431;6179.783707570214;6182.536309776875;6195 20:09:00 INFO - PROCESS | 6289 | |4;prototype.html;290.15130742577963;296.49003713612586;304.57055551672136;313.306027149863;315.8752292844328;6164.568480206387;6243.407930977606;6253;6368.904466433008;6413.102165696806;6226.315105338409;6249.875002499959;6263.561550691454;6276.780312689057;6281.120643109968;4398.714083584573;4505.144022635705;4602.907941841161;4621.44542654881;4623.514530974249;4610.469795973456;4619.722816630996;4624.930626040612;4641.814327426899;4649.04694537619;4542.318652202163;4543.068670922469;4567.337736028274;4573.656975726817;4597.747123908183;4581.496035436099;4591.4260717410325;4594.196015697256;4600.125976064537;4614.492405835355;3902.1415288636454;3903.941440878389;3906.980465097685;3910.276598829197;3920.470736450571;5904.7342869570975;5942.64344139353;5943.55423343251;5948.643081415129;5977.701114944235;5127.282180494733;5312.1766126250495;5331.493508116722;5343.465653434664;5350.91973620396;6538.77114301002;6543.312952140052;6564.474842012675;6570;6583.736650533973;4281.357796330544;4286.935695964563;4291.828326866922;4305.698601097924;4313.1158112586845;6850.554713943628;6876.862462750767;6934.965325173393;6938.930610693879;6945.51381403302;4317.330813723878;4345;4414.690971631955;4418.911621767546;4442.511323754385;4470.441194850644;4474.552544745499;4506.526814684476;4508.07584445188;4520.299353600197;5320.015797077553;5329.280547126088;5344.518993290622;5350.117230656976;5352.8661783454945;6734.46124310054;6740.898886516707;6751.493637977172;6769.526133170729;6771.4582833373215;1551.5888289603265;1562.093985488414;1562.8437156284508;1563.5074951390275;1566.3108232377717;971.1939090554822;1017.3641474078701;1022.0239671114068;1023.8771347438206;1028.1723212813756;6368.363163683687;6378.202724659418;6379.425851673279;6386.616802991743;6401.359864013654;6775.085363475966;6821.147356580427;6826.283240259801;6826.829329266808;6827.624480653512;6350.872982540416;6403.903941440882;6409.1668083149825;6409.8718025640155;6418.582792118497;3656.2687462507606;3689.1699367642605;3695.187058847103;3698.7225958052713;3701.777893326409;7032.92967070333;7204.603746793977;7283.672234749449;7286.23494533077;7316.268373162641;6977.372036516738;7025.367716905503;7025.613591252531;7033.331833475811;7036.190838053587;7205.71177152908;7236.782896513113;7246.782596522113;7270.309320614533;7274.59989700561;6771.187457505131;6785.321467853175;6810.557313774787;6813.625250611066;6830.692618832264;6607.174103237096;6752.966235168793;6804.965975170093;6850.38346548813;6857.074294970115;7282.4902256841515;7303.488755787044;7326.4138868889295;7329.9267007329245;7378.667959941923;4308.4399028126145;4367.388565600755;4372.628326592276;4373.409589705349;4376.49670287921;6658.1344425224415;6813.7955861324235;6867.278935711678;6919.723211071702;6923.446124309942;6642.070110184674;6681.5656982296;6686.398224159849;6694.497912656668;6706.83232919181;6657.234418041793;6662.866742665216;6665.900011499734;6669.799906002828;6674.16572928384;6496.187976502937;6541.509386795914;6549;6556.606603603608;6556.770513032021;6527.869442611026;6612.437942774918;6671.099401580725;6674;6721.764738234138;6516.6415847128865;6528.706208220547;6534.607923524603;6545.952647576365;6547.869042619216 20:09:00 INFO - PROCESS | 6289 | |5;yui.html;748.2816496163679;751.1511991449664;825.7180479787729;831.4617956779956;840.1262686805723;14100.929495352522;14237.00340976132;14251.78622320666;14257.786133207997;14260.073095248814;13530.797038044437;13552.864471355284;13555.52555660552;13556.593302200925;13625.523106691267;676.5636164673795;805.569020573993;816.7100679258866;818.0674031603976;823.0493779684474;798.8162722573811;809.017044291186;809.720646376999;813.5403497024192;829.713748756678;844.4553263145268;844.9873251901196;850.8298340331927;852.1648784191497;873.9213470787628;836.7071524966274;836.9832603347929;852.1052894460822;864.369010622243;865.1824026295153;642.6915080761214;644.983875403114;645.3481983196958;645.502962718704;646.0664340028613;13790.310484475836;13815.585532434043;13877.444902203899;13915.30423478822;13940.302984850718;13218.735625287536;13318.200907945555;13402.731945361136;13430.127041742255;13518.86481135186;10765.569377224901;10950.726231844188;10960.397178155199;11041.889581104166;11494.770104597945;3700.0749812546865;3760.905977350561;3858.3826587745825;3865.362215234483;3865.61343865614;47024.7648761754;47290.05419891617;47379.52620473786;47479.76260118712;47540.28689569659;10391.220658450646;10452.843207351896;10549.367037977747;10597.62908298206;10684.893151068545;19123.521911952314;19184.328548501013;19192;19194.904025480064;19207.51981200453;7760.146383897767;7801.609919504002;7909.920900791033;7991.640376183086;7992;4452.844150454784;4478.79845406951;4508.346289787963;4514.796834142406;4716;3037.9848100759355;3062.081375587315;3066.463368910476;3097.0089571336957;3104.5653608494827;560.2856358143318;563.4815969308246;564.0326839470329;566.4646908671349;568.5480043365534;634.552640388525;642.868551349628;648.7340190521863;660.8215781738903;675.560885424478;7732.7680169595005;8449.619767110371;8487.363447741443;8564.828703426021;8614.138586141336;623.6819222196713;641.1216633212529;646.6669665122465;647.4755448087064;647.6696884588894;3812.1028018705983;3833.290841194388;3835.520559930009;3997.560268370477;4011.338129208648;54889.451105488435;55341.44658553443;55358.72320638371;55438.16842747362;55787.16319255214;48361.27458088131;49276.26085608719;49875;49996.50003499991;50377.24434133491;44790.77604611956;44987;45083.323750143776;46074.30888536674;46101;7747.457677962489;7804.829275608704;7982.201779822203;8076.232757887991;8171.632276547451;34413;34514;34686.65313346834;34891.4766278501;35773.284534308645;40099.599004009586;41705.58294417139;43366.34950475682;43672;44048.55951440573;10338.793224135325;10371.429571373646;10395;10396.116330112025;10653.360798352123;11234.494447749707;11324.6036388726;11630.069594432594;12002.579909703467;12055.939720301343;10532.789344213226;10534;10770.623028193975;10847.40339281347;11148.721281968015;10070.949645251727;10128.291019628556;10130.104572360395;10245.129164020844;10519.789604208027;10510.316829406063;10894.074003709773;11181.32912025281;11359.432028398713;11490.655280341603;8704.303655707401;8810.691625793066;8937.642494300415;9138.17756401927;9144.314176436661;8387.203215694743;8698.21716045559;8726.432781869158;8986.955065224633;9072.591733372146 20:09:00 INFO - PROCESS | 6289 | __end_tp_report 20:09:00 INFO - PROCESS | 6289 | __start_cc_report 20:09:00 INFO - PROCESS | 6289 | _x_x_mozilla_cycle_collect,313 20:09:00 INFO - PROCESS | 6289 | __end_cc_report 20:09:00 INFO - PROCESS | 6289 | __startTimestamp1456805340816__endTimestamp 20:09:00 INFO - PROCESS | 6289 | 20:09:00 INFO - PROCESS | 6289 | ------- Summary: start ------- 20:09:00 INFO - PROCESS | 6289 | Number of tests: 6 20:09:00 INFO - PROCESS | 6289 | 20:09:00 INFO - PROCESS | 6289 | [#0] dojo.html Cycles:165 Average:5254.67 Median:5455.62 stddev:568.97 (10.4%) stddev-sans-first:547.59 20:09:00 INFO - PROCESS | 6289 | Values: 3208.0 3229.0 3258.0 3271.2 3279.8 5201.7 5292.2 5331.3 5334.7 5341.0 5182.1 5201.7 5212.9 5263.5 5267.0 4786.4 4834.3 4923.5 4964.7 4994.5 4717.5 4764.3 4878.8 4900.4 4902.8 4779.2 4795.9 4817.0 4822.3 4858.1 4813.6 4820.8 4820.8 4834.6 4859.0 4801.6 4809.3 4813.0 4852.0 4891.9 5026.4 5129.1 5153.0 5172.4 5176.9 5671.6 5673.5 5681.6 5696.9 5722.7 5537.9 5638.9 5640.9 5688.8 5714.3 5347.0 5351.0 5359.4 5363.8 5380.2 5662.2 5836.8 5840.9 5841.7 5855.7 5540.9 5548.6 5583.3 5586.9 5609.7 5562.9 5655.1 5719.9 5729.3 5741.3 5615.2 5682.9 5689.2 5696.9 5707.4 5565.8 5628.3 5638.5 5643.7 5692.9 4293.4 4323.7 4334.9 4338.9 4372.0 3865.7 3868.9 3911.4 3918.1 3918.9 5363.9 5396.2 5414.2 5421.7 5464.6 5652.1 5680.5 5705.8 5707.5 5709.4 5285.9 5412.7 5418.6 5452.7 5466.1 4677.6 4702.1 4712.4 4747.6 4771.9 5751.4 5804.5 5811.4 5815.1 5838.7 5497.5 5576.2 5584.2 5599.4 5679.7 5770.6 5778.8 5787.2 5789.0 5839.9 5435.5 5440.0 5441.0 5441.2 5466.7 5536.4 5570.1 5579.2 5617.5 5647.7 5385.5 5439.9 5449.2 5465.5 5504.4 5455.6 5538.4 5540.2 5545.4 5554.4 5391.9 5430.9 5494.5 5517.9 5569.8 5561.7 5567.5 5572.3 5607.7 5611.6 5474.8 5483.7 5486.1 5495.3 5535.4 20:09:00 INFO - PROCESS | 6289 | 20:09:00 INFO - PROCESS | 6289 | [#1] ext.html Cycles:180 Average:47787.06 Median:37018.85 stddev:87255.15 (235.7%) stddev-sans-first:87427.72 20:09:00 INFO - PROCESS | 6289 | Values: 507.1 508.7 531.4 534.2 556.6 36944.1 37076.3 37253.6 37407.3 37493.6 40546.8 40834.4 40967.8 41130.0 41186.2 8403.6 8609.2 8662.2 8689.9 8700.2 8344.6 8451.5 8454.2 8463.5 8464.9 8713.5 8826.0 8838.7 8843.7 8874.5 8705.2 8773.4 8806.0 8846.6 8852.0 8575.4 8759.0 8770.8 8772.6 8781.7 40096.0 40492.0 40527.8 40569.6 40604.8 2835.8 3191.1 3241.9 3413.9 3497.4 27162.0 27529.4 28050.9 28447.0 28761.0 3886.0 3898.9 3908.9 3985.6 4015.8 260618.0 263807.0 264003.0 264941.0 265519.0 41266.8 41906.8 61821.0 62544.7 62599.7 40517.8 40591.0 40591.8 40748.8 40934.6 12904.9 12933.4 12990.5 13016.9 13061.7 10124.9 10126.3 10168.0 10185.9 10208.6 13894.2 14311.6 14333.6 14385.1 14428.8 5743.3 5756.3 5833.4 5867.5 5875.7 976.3 1024.4 1030.1 1035.1 1051.9 28586.4 28752.3 28901.6 28916.7 29218.4 1085.7 1146.7 1173.4 1176.1 1181.0 15025.9 15150.3 15194.8 15325.9 15415.5 292853.0 443230.0 446875.0 447290.0 449202.0 50890.7 51175.2 51381.7 51530.0 51729.0 1338.2 1350.0 1358.4 1363.6 1364.6 27350.7 28356.7 28865.9 28933.3 28982.3 46441.0 46930.8 47056.0 47243.0 47340.5 279062.0 287587.0 287774.6 288011.0 288516.0 31407.2 31444.0 31678.7 31769.2 31883.0 42966.8 43329.4 43713.1 44304.6 44324.0 35286.2 35748.0 36129.0 36961.4 37486.4 36564.5 36637.5 37190.8 37245.0 37640.8 35735.5 36488.8 36646.3 36894.6 37182.0 31287.5 33419.8 33943.3 34239.0 34425.0 24890.6 25589.9 25696.4 25795.1 25837.6 20:09:00 INFO - PROCESS | 6289 | 20:09:00 INFO - PROCESS | 6289 | [#2] jquery.html Cycles:180 Average:22519.75 Median:17253.07 stddev:57165.43 (331.3%) stddev-sans-first:57301.54 20:09:00 INFO - PROCESS | 6289 | Values: 341.3 346.3 349.7 350.4 350.9 16164.8 16455.3 16787.7 17125.8 17219.6 15012.1 15017.6 15869.9 16241.8 16291.3 4700.5 5180.5 5329.5 5375.8 5419.1 5206.1 5324.4 5330.7 5355.3 5359.2 5094.4 5295.2 5297.3 5298.2 5303.0 5246.0 5265.4 5285.3 5296.9 5307.3 4622.0 4652.4 4672.7 4681.1 4683.6 20048.1 20261.4 20698.6 20717.8 20943.5 2173.8 2235.6 2286.1 2301.2 2354.7 8364.5 8749.2 12945.6 13138.8 13489.9 1798.5 1867.1 1875.5 1937.9 1966.6 55395.4 58083.7 61309.4 62611.4 65960.7 9910.3 10095.6 10362.1 10422.7 10538.1 13739.9 13790.4 13795.5 13855.7 13947.7 6843.7 7001.2 7021.9 7131.4 7133.5 6607.7 6699.3 6710.5 6775.1 6790.3 4438.8 4499.1 4517.5 4519.5 4608.7 1771.4 1796.7 1870.9 1900.3 1920.7 965.8 974.8 984.6 1040.6 1081.3 16266.3 16715.5 16938.5 17031.7 17238.9 929.0 954.6 963.6 1004.4 1023.4 9551.3 9642.2 9645.7 9648.5 9738.1 323155.0 327696.0 330181.0 334493.0 409171.0 65583.7 69224.0 75320.0 77186.0 77992.6 975.6 1007.8 1009.2 1011.5 1030.2 14423.5 15102.9 15326.6 15401.2 15780.8 33630.3 33845.2 34159.8 34725.7 35148.5 42703.4 45224.3 45422.8 45802.0 46299.5 7635.6 7686.1 7785.2 7907.7 8000.8 8896.2 11529.9 11766.3 11847.1 12270.4 10323.5 10648.8 10931.9 11043.6 11076.9 10164.8 10632.5 10731.8 10816.2 10962.9 10709.8 10787.8 11059.2 11116.0 11330.2 7102.0 7415.8 7505.1 7522.7 7527.1 9381.3 10205.1 10516.3 10637.8 10670.3 20:09:00 INFO - PROCESS | 6289 | 20:09:00 INFO - PROCESS | 6289 | [#3] mootools.html Cycles:180 Average:5133.85 Median:6184.49 stddev:2606.04 (42.1%) stddev-sans-first:2598.90 20:09:00 INFO - PROCESS | 6289 | Values: 1481.6 1500.7 1671.8 1772.2 1794.8 6440.0 7104.9 7229.9 7361.2 7381.6 7254.5 7333.5 7336.4 7403.7 7414.7 2212.7 2242.8 2253.8 2257.2 2261.2 2177.4 2192.8 2236.4 2237.6 2247.1 2245.0 2257.7 2273.6 2273.9 2282.0 2206.0 2209.5 2239.6 2242.7 2243.1 2205.8 2210.2 2212.5 2230.9 2231.3 7446.0 7457.1 7465.1 7494.0 7496.5 4401.6 4447.9 4478.0 4485.3 4499.9 2933.1 3071.0 3080.8 3093.8 3114.4 977.2 986.2 990.8 1016.2 1017.0 9756.7 9796.8 9811.0 9833.0 9848.9 4005.1 4061.8 4111.8 4132.4 4151.4 8314.7 8331.5 8338.1 8362.0 8391.2 4475.1 4478.0 4483.9 4506.5 4516.2 3683.9 4023.6 4042.8 4064.2 4100.6 3508.2 3587.4 3589.8 3595.1 3641.5 1151.7 1169.9 1172.4 1173.5 1178.5 1302.4 1317.6 1321.8 1370.9 1371.1 6835.2 6880.1 6998.0 7005.7 7021.6 484.8 490.5 492.1 493.2 498.0 5457.0 5468.6 5478.9 5497.2 5546.0 8601.4 8690.1 8917.3 8939.8 8977.0 8725.4 8822.9 8837.1 8866.3 8953.1 6662.1 6836.1 6846.5 6920.7 7054.9 6760.4 6765.4 6793.2 6807.0 6819.9 7596.4 7847.3 7851.6 7878.2 7949.5 7841.5 8037.2 8057.8 8071.4 8159.9 5911.0 6240.9 6338.3 6453.4 6511.3 6884.3 6895.0 6905.8 6913.7 6923.3 6083.5 6147.3 6209.2 6248.5 6309.6 6186.4 6228.2 6288.2 6316.4 6330.8 6579.6 6581.0 6588.9 6605.3 6619.3 6159.4 6159.9 6245.1 6246.7 6251.0 6110.5 6141.1 6179.8 6182.5 6195.0 20:09:00 INFO - PROCESS | 6289 | 20:09:00 INFO - PROCESS | 6289 | [#4] prototype.html Cycles:180 Average:5488.65 Median:6378.81 stddev:1747.45 (27.4%) stddev-sans-first:1708.24 20:09:00 INFO - PROCESS | 6289 | Values: 290.2 296.5 304.6 313.3 315.9 6164.6 6243.4 6253.0 6368.9 6413.1 6226.3 6249.9 6263.6 6276.8 6281.1 4398.7 4505.1 4602.9 4621.4 4623.5 4610.5 4619.7 4624.9 4641.8 4649.0 4542.3 4543.1 4567.3 4573.7 4597.7 4581.5 4591.4 4594.2 4600.1 4614.5 3902.1 3903.9 3907.0 3910.3 3920.5 5904.7 5942.6 5943.6 5948.6 5977.7 5127.3 5312.2 5331.5 5343.5 5350.9 6538.8 6543.3 6564.5 6570.0 6583.7 4281.4 4286.9 4291.8 4305.7 4313.1 6850.6 6876.9 6935.0 6938.9 6945.5 4317.3 4345.0 4414.7 4418.9 4442.5 4470.4 4474.6 4506.5 4508.1 4520.3 5320.0 5329.3 5344.5 5350.1 5352.9 6734.5 6740.9 6751.5 6769.5 6771.5 1551.6 1562.1 1562.8 1563.5 1566.3 971.2 1017.4 1022.0 1023.9 1028.2 6368.4 6378.2 6379.4 6386.6 6401.4 6775.1 6821.1 6826.3 6826.8 6827.6 6350.9 6403.9 6409.2 6409.9 6418.6 3656.3 3689.2 3695.2 3698.7 3701.8 7032.9 7204.6 7283.7 7286.2 7316.3 6977.4 7025.4 7025.6 7033.3 7036.2 7205.7 7236.8 7246.8 7270.3 7274.6 6771.2 6785.3 6810.6 6813.6 6830.7 6607.2 6753.0 6805.0 6850.4 6857.1 7282.5 7303.5 7326.4 7329.9 7378.7 4308.4 4367.4 4372.6 4373.4 4376.5 6658.1 6813.8 6867.3 6919.7 6923.4 6642.1 6681.6 6686.4 6694.5 6706.8 6657.2 6662.9 6665.9 6669.8 6674.2 6496.2 6541.5 6549.0 6556.6 6556.8 6527.9 6612.4 6671.1 6674.0 6721.8 6516.6 6528.7 6534.6 6546.0 6547.9 20:09:00 INFO - PROCESS | 6289 | 20:09:00 INFO - PROCESS | 6289 | [#5] yui.html Cycles:180 Average:13581.36 Median:24799.06 stddev:15482.12 (62.4%) stddev-sans-first:15495.56 20:09:00 INFO - PROCESS | 6289 | Values: 748.3 751.2 825.7 831.5 840.1 14100.9 14237.0 14251.8 14257.8 14260.1 13530.8 13552.9 13555.5 13556.6 13625.5 676.6 805.6 816.7 818.1 823.0 798.8 809.0 809.7 813.5 829.7 844.5 845.0 850.8 852.2 873.9 836.7 837.0 852.1 864.4 865.2 642.7 645.0 645.3 645.5 646.1 13790.3 13815.6 13877.4 13915.3 13940.3 13218.7 13318.2 13402.7 13430.1 13518.9 10765.6 10950.7 10960.4 11041.9 11494.8 3700.1 3760.9 3858.4 3865.4 3865.6 47024.8 47290.1 47379.5 47479.8 47540.3 10391.2 10452.8 10549.4 10597.6 10684.9 19123.5 19184.3 19192.0 19194.9 19207.5 7760.1 7801.6 7909.9 7991.6 7992.0 4452.8 4478.8 4508.3 4514.8 4716.0 3038.0 3062.1 3066.5 3097.0 3104.6 560.3 563.5 564.0 566.5 568.5 634.6 642.9 648.7 660.8 675.6 7732.8 8449.6 8487.4 8564.8 8614.1 623.7 641.1 646.7 647.5 647.7 3812.1 3833.3 3835.5 3997.6 4011.3 54889.5 55341.4 55358.7 55438.2 55787.2 48361.3 49276.3 49875.0 49996.5 50377.2 44790.8 44987.0 45083.3 46074.3 46101.0 7747.5 7804.8 7982.2 8076.2 8171.6 34413.0 34514.0 34686.7 34891.5 35773.3 40099.6 41705.6 43366.3 43672.0 44048.6 10338.8 10371.4 10395.0 10396.1 10653.4 11234.5 11324.6 11630.1 12002.6 12055.9 10532.8 10534.0 10770.6 10847.4 11148.7 10070.9 10128.3 10130.1 10245.1 10519.8 10510.3 10894.1 11181.3 11359.4 11490.7 8704.3 8810.7 8937.6 9138.2 9144.3 8387.2 8698.2 8726.4 8987.0 9072.6 20:09:00 INFO - PROCESS | 6289 | -------- Summary: end -------- 20:09:00 INFO - PROCESS | 6289 | 20:09:00 INFO - PROCESS | 6289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:00 INFO - PROCESS | 6289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:00 INFO - PROCESS | 6289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:00 INFO - PROCESS | 6289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:00 INFO - PROCESS | 6289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:00 INFO - PROCESS | 6289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:00 INFO - PROCESS | 6289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:00 INFO - PROCESS | 6289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:00 INFO - PROCESS | 6289 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:01 INFO - TEST-INFO | 6289: exit 0 20:09:01 INFO - TEST-OK | dromaeo_css | took 1173477ms 20:09:01 INFO - TEST-START | kraken 20:09:01 INFO - operating with platform_type : linux_ 20:09:01 INFO - Initialising browser for kraken test... 20:09:01 INFO - TEST-INFO | started process 6529 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt1N22D/profile http://localhost:50133/getInfo.html) 20:09:09 INFO - PROCESS | 6529 | 20:09:09 INFO - PROCESS | 6529 | (process:6598): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:09:12 INFO - PROCESS | 6529 | __metrics Screen width/height:1600/1200 20:09:12 INFO - PROCESS | 6529 | colorDepth:24 20:09:12 INFO - PROCESS | 6529 | Browser inner width/height: 1024/697 20:09:12 INFO - PROCESS | 6529 | __metrics 20:09:13 ERROR - PROCESS | 6529 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 20:09:13 INFO - PROCESS | 6529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:13 INFO - PROCESS | 6529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:13 INFO - PROCESS | 6529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:13 INFO - PROCESS | 6529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:13 INFO - PROCESS | 6529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:13 INFO - PROCESS | 6529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:13 INFO - PROCESS | 6529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:13 INFO - PROCESS | 6529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:13 INFO - PROCESS | 6529 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:09:15 INFO - TEST-INFO | 6529: exit 0 20:09:15 INFO - Browser initialized. 20:09:15 INFO - Running cycle 1/1 for kraken test... 20:09:15 INFO - TEST-INFO | started process 6648 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt1N22D/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:16 INFO - PROCESS | 6648 | 20:09:16 INFO - PROCESS | 6648 | (process:6704): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:09:26 INFO - PROCESS | 6648 | RSS: Main: 161501184 20:09:26 INFO - PROCESS | 6648 | 20:09:29 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50133/tests/kraken/driver.html?testName=audio-beat-detection) 20:09:30 INFO - PROCESS | 6648 | RSS: Main: 168116224 20:09:30 INFO - PROCESS | 6648 | 20:09:32 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50133/tests/kraken/driver.html?testName=audio-dft) 20:09:33 INFO - PROCESS | 6648 | RSS: Main: 170319872 20:09:33 INFO - PROCESS | 6648 | 20:09:36 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50133/tests/kraken/driver.html?testName=audio-fft) 20:09:36 INFO - PROCESS | 6648 | RSS: Main: 163028992 20:09:36 INFO - PROCESS | 6648 | 20:09:38 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50133/tests/kraken/driver.html?testName=audio-oscillator) 20:09:39 INFO - PROCESS | 6648 | RSS: Main: 162082816 20:09:39 INFO - PROCESS | 6648 | 20:09:41 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50133/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:09:42 INFO - PROCESS | 6648 | RSS: Main: 164544512 20:09:42 INFO - PROCESS | 6648 | 20:09:45 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50133/tests/kraken/driver.html?testName=imaging-darkroom) 20:09:45 INFO - PROCESS | 6648 | RSS: Main: 164720640 20:09:45 INFO - PROCESS | 6648 | 20:09:49 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50133/tests/kraken/driver.html?testName=imaging-desaturate) 20:09:49 INFO - PROCESS | 6648 | RSS: Main: 165429248 20:09:49 INFO - PROCESS | 6648 | 20:09:52 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50133/tests/kraken/driver.html?testName=json-parse-financial) 20:09:53 INFO - PROCESS | 6648 | RSS: Main: 167297024 20:09:53 INFO - PROCESS | 6648 | 20:09:54 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50133/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:09:55 INFO - PROCESS | 6648 | RSS: Main: 166207488 20:09:55 INFO - PROCESS | 6648 | 20:09:57 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:09:57 INFO - PROCESS | 6648 | RSS: Main: 166023168 20:09:57 INFO - PROCESS | 6648 | 20:09:59 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:10:00 INFO - PROCESS | 6648 | RSS: Main: 168439808 20:10:00 INFO - PROCESS | 6648 | 20:10:02 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:10:03 INFO - PROCESS | 6648 | RSS: Main: 168026112 20:10:03 INFO - PROCESS | 6648 | 20:10:07 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:10:09 INFO - PROCESS | 6648 | RSS: Main: 168148992 20:10:09 INFO - PROCESS | 6648 | 20:10:10 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50133/tests/kraken/driver.html?testName=ai-astar) 20:10:11 INFO - PROCESS | 6648 | RSS: Main: 164331520 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | __start_tp_report 20:10:11 INFO - PROCESS | 6648 | _x_x_mozilla_page_load 20:10:11 INFO - PROCESS | 6648 | _x_x_mozilla_page_load_details 20:10:11 INFO - PROCESS | 6648 | |i|pagename|runs| 20:10:11 INFO - PROCESS | 6648 | |0;ai-astar;112;111;114;112;112;124;115;114;113;112 20:10:11 INFO - PROCESS | 6648 | |1;audio-beat-detection;152;129;153;186;126;155;155;127;165;130 20:10:11 INFO - PROCESS | 6648 | |2;audio-dft;163;165;162;164;163;166;164;166;169;165 20:10:11 INFO - PROCESS | 6648 | |3;audio-fft;72;73;76;74;74;134;75;73;73;74 20:10:11 INFO - PROCESS | 6648 | |4;audio-oscillator;95;96;138;99;96;95;138;95;96;147 20:10:11 INFO - PROCESS | 6648 | |5;imaging-gaussian-blur;120;116;114;115;115;115;116;115;116;116 20:10:11 INFO - PROCESS | 6648 | |6;imaging-darkroom;147;149;147;146;148;146;147;147;147;147 20:10:11 INFO - PROCESS | 6648 | |7;imaging-desaturate;96;97;97;97;99;96;96;97;97;97 20:10:11 INFO - PROCESS | 6648 | |8;json-parse-financial;59;57;58;56;57;58;56;62;56;54 20:10:11 INFO - PROCESS | 6648 | |9;json-stringify-tinderbox;68;69;68;68;68;69;69;69;71;69 20:10:11 INFO - PROCESS | 6648 | |10;stanford-crypto-aes;90;83;84;86;84;85;83;84;83;85 20:10:11 INFO - PROCESS | 6648 | |11;stanford-crypto-ccm;122;117;120;122;119;122;117;121;129;120 20:10:11 INFO - PROCESS | 6648 | |12;stanford-crypto-pbkdf2;139;140;151;155;152;139;148;150;156;147 20:10:11 INFO - PROCESS | 6648 | |13;stanford-crypto-sha256-iterative;70;70;69;70;72;71;77;77;74;69 20:10:11 INFO - PROCESS | 6648 | __end_tp_report 20:10:11 INFO - PROCESS | 6648 | __start_cc_report 20:10:11 INFO - PROCESS | 6648 | _x_x_mozilla_cycle_collect,790 20:10:11 INFO - PROCESS | 6648 | __end_cc_report 20:10:11 INFO - PROCESS | 6648 | __startTimestamp1456805411121__endTimestamp 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | ------- Summary: start ------- 20:10:11 INFO - PROCESS | 6648 | Number of tests: 14 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#0] ai-astar Cycles:10 Average:113.90 Median:113.50 stddev:3.75 (3.3%) stddev-sans-first:3.92 20:10:11 INFO - PROCESS | 6648 | Values: 112.0 111.0 114.0 112.0 112.0 124.0 115.0 114.0 113.0 112.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:154.00 stddev:19.67 (12.8%) stddev-sans-first:20.80 20:10:11 INFO - PROCESS | 6648 | Values: 152.0 129.0 153.0 186.0 126.0 155.0 155.0 127.0 165.0 130.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:2.00 (1.2%) stddev-sans-first:2.03 20:10:11 INFO - PROCESS | 6648 | Values: 163.0 165.0 162.0 164.0 163.0 166.0 164.0 166.0 169.0 165.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.00 stddev:19.08 (25.8%) stddev-sans-first:20.02 20:10:11 INFO - PROCESS | 6648 | Values: 72.0 73.0 76.0 74.0 74.0 134.0 75.0 73.0 73.0 74.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:95.50 stddev:21.91 (22.9%) stddev-sans-first:22.60 20:10:11 INFO - PROCESS | 6648 | Values: 95.0 96.0 138.0 99.0 96.0 95.0 138.0 95.0 96.0 147.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:116.00 stddev:1.62 (1.4%) stddev-sans-first:0.71 20:10:11 INFO - PROCESS | 6648 | Values: 120.0 116.0 114.0 115.0 115.0 115.0 116.0 115.0 116.0 116.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 20:10:11 INFO - PROCESS | 6648 | Values: 147.0 149.0 147.0 146.0 148.0 146.0 147.0 147.0 147.0 147.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 20:10:11 INFO - PROCESS | 6648 | Values: 96.0 97.0 97.0 97.0 99.0 96.0 96.0 97.0 97.0 97.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:2.16 (3.8%) stddev-sans-first:2.20 20:10:11 INFO - PROCESS | 6648 | Values: 59.0 57.0 58.0 56.0 57.0 58.0 56.0 62.0 56.0 54.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 20:10:11 INFO - PROCESS | 6648 | Values: 68.0 69.0 68.0 68.0 68.0 69.0 69.0 69.0 71.0 69.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:2.11 (2.5%) stddev-sans-first:1.05 20:10:11 INFO - PROCESS | 6648 | Values: 90.0 83.0 84.0 86.0 84.0 85.0 83.0 84.0 83.0 85.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.50 stddev:3.41 (2.8%) stddev-sans-first:3.60 20:10:11 INFO - PROCESS | 6648 | Values: 122.0 117.0 120.0 122.0 119.0 122.0 117.0 121.0 129.0 120.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:150.50 stddev:6.40 (4.2%) stddev-sans-first:5.96 20:10:11 INFO - PROCESS | 6648 | Values: 139.0 140.0 151.0 155.0 152.0 139.0 148.0 150.0 156.0 147.0 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.50 stddev:3.07 (4.3%) stddev-sans-first:3.18 20:10:11 INFO - PROCESS | 6648 | Values: 70.0 70.0 69.0 70.0 72.0 71.0 77.0 77.0 74.0 69.0 20:10:11 INFO - PROCESS | 6648 | -------- Summary: end -------- 20:10:11 INFO - PROCESS | 6648 | 20:10:11 INFO - PROCESS | 6648 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:11 INFO - PROCESS | 6648 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:11 INFO - PROCESS | 6648 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:11 INFO - PROCESS | 6648 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:11 INFO - PROCESS | 6648 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 20:10:20 INFO - Browser shutdown timed out after 5 seconds, terminating process. 20:10:20 INFO - Terminating psutil.Process(pid=6648, name='firefox') 20:10:21 INFO - TEST-INFO | 6648: exit 15 20:10:39 INFO - TEST-OK | kraken | took 97317ms 20:10:39 INFO - SUITE-END | took 1270s 20:10:40 INFO - Completed test suite (00:21:11) 20:10:40 INFO - Working with test: dromaeo_css 20:10:40 INFO - Generating results file: dromaeo_css 20:10:40 INFO - Working with test: kraken 20:10:40 INFO - Generating results file: kraken 20:10:40 INFO - javascript benchmark 20:10:40 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:10:40 INFO - process_Request line: dromaeo_css 6805.25 graph.html#tests=[[72,64,43]] 20:10:40 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:40 INFO - process_Request line: kraken 1526.80 graph.html#tests=[[232,64,43]] 20:10:40 INFO - RETURN: dromaeo_css: 6805.25 20:10:40 INFO - RETURN: kraken: 1526.80 20:10:40 INFO - javascript benchmark 20:10:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.9839600801997, 3229.0312906128156, 3258.0, 3271.2149084219777, 3279.83600819959, 5201.739913004353, 5292.153255479124, 5331.333583302087, 5334.706591137486, 5341.0, 5182.144946083891, 5201.661891977028, 5212.947870521293, 5263.499967503081, 5267.0, 4786.353842231289, 4834.3473631059705, 4923.483034281403, 4964.726940018298, 4994.475580064095, 4717.457492388367, 4764.309175169598, 4878.829240976566, 4900.387451568554, 4902.754862256891, 4779.16364636189, 4795.928061079087, 4816.9999999999645, 4822.276658501218, 4858.149823780825, 4813.566778989908, 4820.8071677132875, 4820.831270905502, 4834.6374021948495, 4859.028194361106, 4801.615870730333, 4809.278608208761, 4812.989272252831, 4852.005338905516, 4891.926621100686, 5026.421961474441, 5129.102407078746, 5153.046686362997, 5172.379314482287, 5176.912848301861, 5671.631343962629, 5673.546116310686, 5681.602287839853, 5696.857578560528, 5722.7424765885635, 5537.861553461155, 5638.859028524279, 5640.943590564083, 5688.800891968803, 5714.257146570961, 5347.010803001457, 5351.036813373591, 5359.356877174725, 5363.785448582091, 5380.192971054373, 5662.235598194191, 5836.795712150054, 5840.94159058404, 5841.707914604252, 5855.707214639251, 5540.861478463071, 5548.55611551083, 5583.330000399978, 5586.91619625706, 5609.691466969274, 5562.888742225133, 5655.123455864347, 5719.885602287931, 5729.28383952006, 5741.311042674823, 5615.185798059259, 5682.886342273214, 5689.231953686282, 5696.857578560569, 5707.3721890592005, 5565.805196818092, 5628.296462942132, 5638.548916086703, 5643.661380317194, 5692.8861422771315, 4293.355996600535, 4323.718958267703, 4334.869953901388, 4338.869833904988, 4372.0, 3865.729398942103, 3868.883933482, 3911.3741801311653, 3918.0792513759243, 3918.941215881764, 5363.865903352447, 5396.217548455452, 5414.242006119146, 5421.728913554307, 5464.617476776667, 5652.123920792284, 5680.5455563554815, 5705.82882513517, 5707.543396528268, 5709.371969083398, 5285.867853303698, 5412.729363531807, 5418.620696551282, 5452.727363631802, 5466.125419932791, 4677.6257899367965, 4702.106599746037, 4712.387389639393, 4747.596454301354, 4771.928421073687, 5751.396103409165, 5804.4775970162045, 5811.4479124483105, 5815.127730840408, 5838.737256823369, 5497.47773961473, 5576.191452239322, 5584.246126772834, 5599.440055994368, 5679.659220446786, 5770.567207459541, 5778.797742079007, 5787.160861675117, 5789.015867302484, 5839.883202336015, 5435.456454354533, 5440.047991601533, 5441.0, 5441.238226648194, 5466.726663666721, 5536.363318218457, 5570.053090974463, 5579.246801681721, 5617.522510586646, 5647.7176141193595, 5385.488378604026, 5439.891202176013, 5449.155380915964, 5465.453454654503, 5504.366997795305, 5455.618106732491, 5538.390777014444, 5540.196671482532, 5545.417731138334, 5554.444555544414, 5391.919121213106, 5430.945690543044, 5494.450554944474, 5517.944820551904, 5569.777208911761, 5561.6663000220115, 5567.526760225426, 5572.275604171432, 5607.747651355618, 5611.6352437091455, 5474.835754927359, 5483.7258137092185, 5486.094794358886, 5495.313085864267, 5535.446455354593], "unit": "score", "name": "dojo.html", "value": 5218.908510426726}, {"lowerIsBetter": false, "replicates": [507.0543436490944, 508.73037290236164, 531.4021725558746, 534.156033467122, 556.6409665765582, 36944.07639809006, 37076.25847483049, 37253.62746372535, 37407.25185496295, 37493.62506374936, 40546.79726601363, 40834.38748418776, 40967.79516102423, 41130.0, 41186.17627647445, 8403.57982100894, 8609.225169734722, 8662.17709317617, 8689.869651955225, 8700.216980471756, 8344.624491897848, 8451.492910425393, 8454.154584541528, 8463.534505602189, 8464.915350846504, 8713.477191368538, 8825.955870220672, 8838.734837954871, 8843.734687959339, 8874.467531948103, 8705.216530512253, 8773.429727067753, 8805.955970220171, 8846.646134154595, 8851.955740221258, 8575.399722019461, 8759.0, 8770.780730481725, 8772.561371931442, 8781.692640757543, 40096.0, 40492.0, 40527.7973610133, 40569.594304056875, 40604.79697601523, 2835.7829324369527, 3191.1020224943313, 3241.918952026218, 3413.9146521337166, 3497.422925217336, 27162.0, 27529.44941101167, 28050.859745701346, 28447.0, 28761.0, 3885.9805700971597, 3898.902527436808, 3908.882733517999, 3985.561588225293, 4015.8393664253394, 260618.0, 263807.0, 264003.0, 264941.0, 265519.0, 41266.79366603148, 41906.790466048085, 61821.0, 62544.68727656423, 62599.6870015647, 40517.797411012754, 40591.0, 40591.79704101461, 40748.79625601853, 40934.59065409367, 12904.935475322563, 12933.417996190194, 12990.545330913561, 13016.934915325552, 13061.673458163432, 10124.949375253076, 10126.291159618904, 10168.0, 10185.9490702546, 10208.6426975057, 13894.166350019032, 14311.642208944651, 14333.64165895861, 14385.136891786526, 14428.783568246485, 5743.277016894915, 5756.3380211276235, 5833.358330583633, 5867.501262392659, 5875.707344384228, 976.2775546095838, 1024.4365598920565, 1030.1038096855784, 1035.0684384054412, 1051.9368837869752, 28586.428271434455, 28752.281192970342, 28901.56647650287, 28916.7108328914, 29218.415631687247, 1085.6580177244143, 1146.690393593725, 1173.4426147579832, 1176.0767797279095, 1180.996153269731, 15025.924870375578, 15150.31823567942, 15194.772078418833, 15325.9233703833, 15415.537533874001, 292853.0, 443230.0, 446875.0, 447290.0, 449202.0, 50890.74554627203, 51175.23237151446, 51381.743091284305, 51530.0, 51729.0, 1338.2372047932586, 1350.0414705558967, 1358.4498278197345, 1363.604554679132, 1364.590622813152, 27350.72649273482, 28356.71643283541, 28865.85567072151, 28933.276668083465, 28982.27544311409, 46441.0, 46930.76534617442, 47056.0, 47243.0, 47340.52659473361, 279062.0, 287587.0, 287774.56112719304, 288011.0, 288516.0, 31407.21481962969, 31444.0, 31678.683213167573, 31769.20576985594, 31883.0, 42966.78516607522, 43329.35005974976, 43713.12573748571, 44304.556954430045, 44324.0, 35286.17980448167, 35748.0, 36129.0, 36961.44557831688, 37486.43770343502, 36564.451533227555, 36637.450438242915, 37190.8140459296, 37245.0, 37640.81179594085, 35735.46396804102, 36488.81755591205, 36646.26707465889, 36894.63105368912, 37182.0, 31287.530687039256, 33419.83290083534, 33943.3211335767, 34239.0, 34425.0, 24890.626640600043, 25589.872050639628, 25696.354840159256, 25795.097171598904, 25837.612435813102], "unit": "score", "name": "ext.html", "value": 17881.620045683074}, {"lowerIsBetter": false, "replicates": [341.34121146187846, 346.3091133189287, 349.74818130945727, 350.38157651744666, 350.8719317449132, 16164.75752863708, 16455.34178632856, 16787.748183777254, 17125.82874171258, 17219.569510762238, 15012.099274043565, 15017.62455938602, 15869.92065039676, 16241.83758162418, 16291.348346066172, 4700.459447163577, 5180.507851754077, 5329.520343169114, 5375.838724838261, 5419.051665958461, 5206.088934436478, 5324.41431442541, 5330.733463326837, 5355.3305836770405, 5359.196120581905, 5094.363204599425, 5295.205719142121, 5297.337832770903, 5298.1522956327, 5302.965921645281, 5246.029484545371, 5265.394479634814, 5285.339332583427, 5296.867578310554, 5307.310049693534, 4622.0, 4652.441706995149, 4672.719636821802, 4681.1105889881155, 4683.578477937002, 20048.097835597433, 20261.39215823513, 20698.5860282795, 20717.792822071737, 20943.476413089644, 2173.7717539658265, 2235.58641651295, 2286.074139973297, 2301.240590605113, 2354.693889794333, 8364.456310339869, 8749.16882896124, 12945.611631651065, 13138.802917956238, 13489.932550337186, 1798.5413719501573, 1867.085128287143, 1875.456117725858, 1937.9224831006743, 1966.6263409952064, 55395.44604553943, 58083.709581451825, 61309.38690613037, 62611.37388626146, 65960.6701966492, 9910.256730745223, 10095.596176153018, 10362.119219866396, 10422.687319380431, 10538.104261137889, 13739.931300343635, 13790.379432925542, 13795.517156899661, 13855.653608659662, 13947.651308717363, 6843.657817109125, 7001.194862590765, 7021.859562808715, 7131.393831524379, 7133.466304744505, 6607.669616519155, 6699.330066993359, 6710.530262881649, 6775.0514927910135, 6790.287019862843, 4438.778061096932, 4499.1451624191295, 4517.503074661785, 4519.5480451954545, 4608.677392582487, 1771.353455988555, 1796.6765982123343, 1870.9158087886078, 1900.3063881683086, 1920.7310976463307, 965.7778710896392, 974.7904200596905, 984.5520288268821, 1040.5941682743735, 1081.3187691754301, 16266.268017939221, 16715.498535043967, 16938.49184524466, 17031.65936681284, 17238.913805431144, 929.0477260807592, 954.575214029764, 963.6482683820356, 1004.3873237325225, 1023.4371095897376, 9551.331406801597, 9642.228621710246, 9645.662401815904, 9648.517574121266, 9738.119105685042, 323155.0, 327696.0, 330181.0, 334493.0, 409171.0, 65583.67208164024, 69224.0, 75320.0, 77186.0, 77992.61003695059, 975.6292608808608, 1007.8034783217349, 1009.1523120578603, 1011.5296387179997, 1030.2324768048002, 14423.49517766873, 15102.924485377504, 15326.616834579225, 15401.229938502805, 15780.76328855091, 33630.327393452484, 33845.153871153416, 34159.829200853834, 34725.652743473256, 35148.47277290792, 42703.35944960766, 45224.32163517616, 45422.77288613668, 45802.0, 46299.53700462952, 7635.580043097683, 7686.07767067933, 7785.221477852169, 7907.723229686933, 8000.759977200693, 8896.154865287788, 11529.942350288195, 11766.294022358687, 11847.052235821286, 12270.447829847857, 10323.48382580883, 10648.84026739584, 10931.945340273247, 11043.613473528709, 11076.944615276872, 10164.847527287244, 10632.468376580986, 10731.839022414513, 10816.242862999514, 10962.903709628974, 10709.785804283714, 10787.838182427427, 11059.170562208028, 11116.0, 11330.150238731963, 7102.041224434635, 7415.777526674208, 7505.099388073466, 7522.661480233293, 7527.096748390009, 9381.343305968516, 10205.132563732166, 10516.316439431412, 10637.787244255227, 10670.253082284165], "unit": "score", "name": "jquery.html", "value": 8230.969774836047}, {"lowerIsBetter": false, "replicates": [1481.6147801571592, 1500.6773543688105, 1671.8161002289746, 1772.220223101836, 1794.8474379677727, 6439.967800160993, 7104.893426598605, 7229.855402891945, 7361.190269070405, 7381.557106573603, 7254.528455650392, 7333.486655934087, 7336.449766267525, 7403.740869069584, 7414.703411863533, 2212.6902233687297, 2242.8093612042994, 2253.830962677806, 2257.164849005862, 2261.231181398324, 2177.433867194533, 2192.7807219278025, 2236.37381533171, 2237.6307909195043, 2247.0674670011927, 2245.0346351069115, 2257.6500642400456, 2273.6362182050875, 2273.8863056847176, 2282.0301371916953, 2205.977940220593, 2209.5359974405396, 2239.6192647249845, 2242.7196600424945, 2243.091547923094, 2205.845590808644, 2210.24851550472, 2212.4800671842104, 2230.8884555772147, 2231.2859884836857, 7446.0, 7457.067866516685, 7465.141508726511, 7494.0, 7496.475246732731, 4401.603855653007, 4447.911041779179, 4477.977610111961, 4485.2599321111975, 4499.932501012488, 2933.149386677861, 3070.969290307091, 3080.753539716817, 3093.767967402454, 3114.4082624301536, 977.2426369563645, 986.191323115046, 990.8067926754286, 1016.2479764973866, 1016.9847452288221, 9756.707298781048, 9796.804063918682, 9810.950945245228, 9832.950835245849, 9848.90151098487, 4005.0588111793704, 4061.756294622273, 4111.773852438145, 4132.40080188371, 4151.398047283187, 8314.708985185489, 8331.541765202972, 8338.124496927856, 8362.038365588036, 8391.160883911682, 4475.127350166751, 4478.037221997221, 4483.932741008887, 4506.481754598263, 4516.23224051912, 3683.8710645127294, 4023.6177563131455, 4042.757434553936, 4064.1871625674985, 4100.610442008005, 3508.1755787389943, 3587.4260118381458, 3589.766665166756, 3595.1191957970464, 3641.5266015418356, 1151.717829131868, 1169.92980421175, 1172.4430895324654, 1173.4895320535595, 1178.452019810775, 1302.3618426970716, 1317.5783749200355, 1321.7686904791624, 1370.8903287737157, 1371.081375478432, 6835.179778426521, 6880.105586273752, 6998.020277161201, 7005.719771209095, 7021.613811240329, 484.80123149508535, 490.52419153421124, 492.07735495945104, 493.1591636260168, 498.0, 5456.972715136399, 5468.605505596127, 5478.91781623276, 5497.202905578749, 5546.0, 8601.397902146915, 8690.130986901386, 8917.286617070618, 8939.821203575892, 8976.955115224382, 8725.389222754346, 8822.86765698515, 8837.072107428756, 8866.290696744245, 8953.104689530996, 6662.133922590032, 6836.077129587442, 6846.4522838173825, 6920.723171073201, 7054.858902821915, 6760.425363843931, 6765.357291057342, 6793.218779840184, 6807.047013418224, 6819.863602728017, 7596.354309883501, 7847.293743563107, 7851.56816375082, 7878.212178782076, 7949.483283586548, 7841.529508229524, 8037.196280371916, 8057.798555036171, 8071.434999549975, 8159.8776018358585, 5910.970445147918, 6240.875182496416, 6338.271098823509, 6453.354664533509, 6511.34886511345, 6884.277150899284, 6895.034695142785, 6905.792826215222, 6913.654317284217, 6923.342282483156, 6083.452489275986, 6147.262328520606, 6209.223847019122, 6248.500119990299, 6309.558330916791, 6186.443220110212, 6228.22147231596, 6288.1825362704385, 6316.399942005502, 6330.8100756977365, 6579.605223686594, 6581.045748366556, 6588.868222635616, 6605.339466053549, 6619.3049729779605, 6159.384061593984, 6159.938400615936, 6245.125682404558, 6246.656433896179, 6250.968745156245, 6110.450059494489, 6141.07883817431, 6179.783707570214, 6182.536309776875, 6195.0], "unit": "score", "name": "mootools.html", "value": 4210.783735482295}, {"lowerIsBetter": false, "replicates": [290.15130742577963, 296.49003713612586, 304.57055551672136, 313.306027149863, 315.8752292844328, 6164.568480206387, 6243.407930977606, 6253.0, 6368.904466433008, 6413.102165696806, 6226.315105338409, 6249.875002499959, 6263.561550691454, 6276.780312689057, 6281.120643109968, 4398.714083584573, 4505.144022635705, 4602.907941841161, 4621.44542654881, 4623.514530974249, 4610.469795973456, 4619.722816630996, 4624.930626040612, 4641.814327426899, 4649.04694537619, 4542.318652202163, 4543.068670922469, 4567.337736028274, 4573.656975726817, 4597.747123908183, 4581.496035436099, 4591.4260717410325, 4594.196015697256, 4600.125976064537, 4614.492405835355, 3902.1415288636454, 3903.941440878389, 3906.980465097685, 3910.276598829197, 3920.470736450571, 5904.7342869570975, 5942.64344139353, 5943.55423343251, 5948.643081415129, 5977.701114944235, 5127.282180494733, 5312.1766126250495, 5331.493508116722, 5343.465653434664, 5350.91973620396, 6538.77114301002, 6543.312952140052, 6564.474842012675, 6570.0, 6583.736650533973, 4281.357796330544, 4286.935695964563, 4291.828326866922, 4305.698601097924, 4313.1158112586845, 6850.554713943628, 6876.862462750767, 6934.965325173393, 6938.930610693879, 6945.51381403302, 4317.330813723878, 4345.0, 4414.690971631955, 4418.911621767546, 4442.511323754385, 4470.441194850644, 4474.552544745499, 4506.526814684476, 4508.07584445188, 4520.299353600197, 5320.015797077553, 5329.280547126088, 5344.518993290622, 5350.117230656976, 5352.8661783454945, 6734.46124310054, 6740.898886516707, 6751.493637977172, 6769.526133170729, 6771.4582833373215, 1551.5888289603265, 1562.093985488414, 1562.8437156284508, 1563.5074951390275, 1566.3108232377717, 971.1939090554822, 1017.3641474078701, 1022.0239671114068, 1023.8771347438206, 1028.1723212813756, 6368.363163683687, 6378.202724659418, 6379.425851673279, 6386.616802991743, 6401.359864013654, 6775.085363475966, 6821.147356580427, 6826.283240259801, 6826.829329266808, 6827.624480653512, 6350.872982540416, 6403.903941440882, 6409.1668083149825, 6409.8718025640155, 6418.582792118497, 3656.2687462507606, 3689.1699367642605, 3695.187058847103, 3698.7225958052713, 3701.777893326409, 7032.92967070333, 7204.603746793977, 7283.672234749449, 7286.23494533077, 7316.268373162641, 6977.372036516738, 7025.367716905503, 7025.613591252531, 7033.331833475811, 7036.190838053587, 7205.71177152908, 7236.782896513113, 7246.782596522113, 7270.309320614533, 7274.59989700561, 6771.187457505131, 6785.321467853175, 6810.557313774787, 6813.625250611066, 6830.692618832264, 6607.174103237096, 6752.966235168793, 6804.965975170093, 6850.38346548813, 6857.074294970115, 7282.4902256841515, 7303.488755787044, 7326.4138868889295, 7329.9267007329245, 7378.667959941923, 4308.4399028126145, 4367.388565600755, 4372.628326592276, 4373.409589705349, 4376.49670287921, 6658.1344425224415, 6813.7955861324235, 6867.278935711678, 6919.723211071702, 6923.446124309942, 6642.070110184674, 6681.5656982296, 6686.398224159849, 6694.497912656668, 6706.83232919181, 6657.234418041793, 6662.866742665216, 6665.900011499734, 6669.799906002828, 6674.16572928384, 6496.187976502937, 6541.509386795914, 6549.0, 6556.606603603608, 6556.770513032021, 6527.869442611026, 6612.437942774918, 6671.099401580725, 6674.0, 6721.764738234138, 6516.6415847128865, 6528.706208220547, 6534.607923524603, 6545.952647576365, 6547.869042619216], "unit": "score", "name": "prototype.html", "value": 4896.597150582126}, {"lowerIsBetter": false, "replicates": [748.2816496163679, 751.1511991449664, 825.7180479787729, 831.4617956779956, 840.1262686805723, 14100.929495352522, 14237.00340976132, 14251.78622320666, 14257.786133207997, 14260.073095248814, 13530.797038044437, 13552.864471355284, 13555.52555660552, 13556.593302200925, 13625.523106691267, 676.5636164673795, 805.569020573993, 816.7100679258866, 818.0674031603976, 823.0493779684474, 798.8162722573811, 809.017044291186, 809.720646376999, 813.5403497024192, 829.713748756678, 844.4553263145268, 844.9873251901196, 850.8298340331927, 852.1648784191497, 873.9213470787628, 836.7071524966274, 836.9832603347929, 852.1052894460822, 864.369010622243, 865.1824026295153, 642.6915080761214, 644.983875403114, 645.3481983196958, 645.502962718704, 646.0664340028613, 13790.310484475836, 13815.585532434043, 13877.444902203899, 13915.30423478822, 13940.302984850718, 13218.735625287536, 13318.200907945555, 13402.731945361136, 13430.127041742255, 13518.86481135186, 10765.569377224901, 10950.726231844188, 10960.397178155199, 11041.889581104166, 11494.770104597945, 3700.0749812546865, 3760.905977350561, 3858.3826587745825, 3865.362215234483, 3865.61343865614, 47024.7648761754, 47290.05419891617, 47379.52620473786, 47479.76260118712, 47540.28689569659, 10391.220658450646, 10452.843207351896, 10549.367037977747, 10597.62908298206, 10684.893151068545, 19123.521911952314, 19184.328548501013, 19192.0, 19194.904025480064, 19207.51981200453, 7760.146383897767, 7801.609919504002, 7909.920900791033, 7991.640376183086, 7992.0, 4452.844150454784, 4478.79845406951, 4508.346289787963, 4514.796834142406, 4716.0, 3037.9848100759355, 3062.081375587315, 3066.463368910476, 3097.0089571336957, 3104.5653608494827, 560.2856358143318, 563.4815969308246, 564.0326839470329, 566.4646908671349, 568.5480043365534, 634.552640388525, 642.868551349628, 648.7340190521863, 660.8215781738903, 675.560885424478, 7732.7680169595005, 8449.619767110371, 8487.363447741443, 8564.828703426021, 8614.138586141336, 623.6819222196713, 641.1216633212529, 646.6669665122465, 647.4755448087064, 647.6696884588894, 3812.1028018705983, 3833.290841194388, 3835.520559930009, 3997.560268370477, 4011.338129208648, 54889.451105488435, 55341.44658553443, 55358.72320638371, 55438.16842747362, 55787.16319255214, 48361.27458088131, 49276.26085608719, 49875.0, 49996.50003499991, 50377.24434133491, 44790.77604611956, 44987.0, 45083.323750143776, 46074.30888536674, 46101.0, 7747.457677962489, 7804.829275608704, 7982.201779822203, 8076.232757887991, 8171.632276547451, 34413.0, 34514.0, 34686.65313346834, 34891.4766278501, 35773.284534308645, 40099.599004009586, 41705.58294417139, 43366.34950475682, 43672.0, 44048.55951440573, 10338.793224135325, 10371.429571373646, 10395.0, 10396.116330112025, 10653.360798352123, 11234.494447749707, 11324.6036388726, 11630.069594432594, 12002.579909703467, 12055.939720301343, 10532.789344213226, 10534.0, 10770.623028193975, 10847.40339281347, 11148.721281968015, 10070.949645251727, 10128.291019628556, 10130.104572360395, 10245.129164020844, 10519.789604208027, 10510.316829406063, 10894.074003709773, 11181.32912025281, 11359.432028398713, 11490.655280341603, 8704.303655707401, 8810.691625793066, 8937.642494300415, 9138.17756401927, 9144.314176436661, 8387.203215694743, 8698.21716045559, 8726.432781869158, 8986.955065224633, 9072.591733372146], "unit": "score", "name": "yui.html", "value": 6270.927781791368}], "name": "dromaeo_css", "value": 6805.2515583816685}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 114.0, 112.0, 112.0, 124.0, 115.0, 114.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [152.0, 129.0, 153.0, 186.0, 126.0, 155.0, 155.0, 127.0, 165.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 162.0, 164.0, 163.0, 166.0, 164.0, 166.0, 169.0, 165.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 76.0, 74.0, 74.0, 134.0, 75.0, 73.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 138.0, 99.0, 96.0, 95.0, 138.0, 95.0, 96.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 114.0, 115.0, 115.0, 115.0, 116.0, 115.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.8}, {"lowerIsBetter": true, "replicates": [147.0, 149.0, 147.0, 146.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 99.0, 96.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 56.0, 57.0, 58.0, 56.0, 62.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [90.0, 83.0, 84.0, 86.0, 84.0, 85.0, 83.0, 84.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [122.0, 117.0, 120.0, 122.0, 119.0, 122.0, 117.0, 121.0, 129.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [139.0, 140.0, 151.0, 155.0, 152.0, 139.0, 148.0, 150.0, 156.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 70.0, 72.0, 71.0, 77.0, 77.0, 74.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1526.8000000000002}]} 20:10:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1526.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6805.25"}}} 20:10:40 INFO - Return code: 0 20:10:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:10:40 ERROR - # TBPL SUCCESS # 20:10:40 INFO - Running post-action listener: _resource_record_post_action 20:10:40 INFO - Running post-run listener: _resource_record_post_run 20:10:41 INFO - Total resource usage - Wall time: 1293s; CPU: 14.0%; Read bytes: 499712; Write bytes: 651169792; Read time: 5168; Write time: 9344028 20:10:41 INFO - install - Wall time: 20s; CPU: 24.0%; Read bytes: 0; Write bytes: 184725504; Read time: 0; Write time: 1466860 20:10:41 INFO - run-tests - Wall time: 1274s; CPU: 14.0%; Read bytes: 499712; Write bytes: 460656640; Read time: 5168; Write time: 7745404 20:10:41 INFO - Running post-run listener: _upload_blobber_files 20:10:41 INFO - Blob upload gear active. 20:10:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:10:41 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:10:41 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:10:41 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:10:42 INFO - (blobuploader) - INFO - Open directory for files ... 20:10:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:10:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:10:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:43 INFO - (blobuploader) - INFO - Done attempting. 20:10:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:10:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:10:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:43 INFO - (blobuploader) - INFO - Done attempting. 20:10:43 INFO - (blobuploader) - INFO - Iteration through files over. 20:10:43 INFO - Return code: 0 20:10:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:10:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:10:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8af4e399c4d7ab04155666b17e72b5a2f4f8af1fbbe9a869ce2887ceeec6b9ac20d07be091073a88630e0f09f7936324d323f015d37a034f64066239fd13d33f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15882607d89dfdafc848d1f402b8cffef27d4cd8ffbf93c6d6372b12653f3b64110c7f5f389b2d9d49c05d29b585929d3861663683e59426c4e018b643f8551f"} 20:10:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:10:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:10:43 INFO - Contents: 20:10:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8af4e399c4d7ab04155666b17e72b5a2f4f8af1fbbe9a869ce2887ceeec6b9ac20d07be091073a88630e0f09f7936324d323f015d37a034f64066239fd13d33f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15882607d89dfdafc848d1f402b8cffef27d4cd8ffbf93c6d6372b12653f3b64110c7f5f389b2d9d49c05d29b585929d3861663683e59426c4e018b643f8551f"} 20:10:43 INFO - Running post-run listener: copy_logs_to_upload_dir 20:10:43 INFO - Copying logs to upload dir... 20:10:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:10:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1339.792996 ========= master_lag: 36.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 56 secs) (at 2016-02-29 20:11:20.729163) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 20:11:20.735150) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313 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/8af4e399c4d7ab04155666b17e72b5a2f4f8af1fbbe9a869ce2887ceeec6b9ac20d07be091073a88630e0f09f7936324d323f015d37a034f64066239fd13d33f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15882607d89dfdafc848d1f402b8cffef27d4cd8ffbf93c6d6372b12653f3b64110c7f5f389b2d9d49c05d29b585929d3861663683e59426c4e018b643f8551f"} build_url:https://queue.taskcluster.net/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010360 build_url: 'https://queue.taskcluster.net/v1/task/bpDYOGYzSu2Ss6glnw5XRQ/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/8af4e399c4d7ab04155666b17e72b5a2f4f8af1fbbe9a869ce2887ceeec6b9ac20d07be091073a88630e0f09f7936324d323f015d37a034f64066239fd13d33f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15882607d89dfdafc848d1f402b8cffef27d4cd8ffbf93c6d6372b12653f3b64110c7f5f389b2d9d49c05d29b585929d3861663683e59426c4e018b643f8551f"}' ========= master_lag: 0.99 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 20:11:21.730639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-29 20:11:21.730955) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456803267.265403-32035313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 1.34 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-29 20:11:23.078657) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 20:11:23.078953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 20:11:23.152957) ========= ========= Total master_lag: 39.33 =========