builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1456875036.7 results: success (0) buildid: 20160301113318 builduid: f4fefbacc2834bb89e04f563937b2d66 revision: 3d5a435bcb168cad644c17c001990a31d1b818d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:36.697802) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:36.698236) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:36.698525) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006424 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:36.740378) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:36.740959) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:36.956336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:36.956641) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.006154) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.006464) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.006813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.007089) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 15:30:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.1M=0s 2016-03-01 15:30:37 (28.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.238566 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.265252) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.265564) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015765 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.315941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.317953) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3d5a435bcb168cad644c17c001990a31d1b818d9 --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 3d5a435bcb168cad644c17c001990a31d1b818d9 --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=2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 15:30:37,518 truncating revision to first 12 chars 2016-03-01 15:30:37,518 Setting DEBUG logging. 2016-03-01 15:30:37,518 attempt 1/10 2016-03-01 15:30:37,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3d5a435bcb16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 15:30:37,840 unpacking tar archive at: fx-team-3d5a435bcb16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592701 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.923155) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.926517) ========= echo 3d5a435bcb168cad644c17c001990a31d1b818d9 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3d5a435bcb168cad644c17c001990a31d1b818d9'] 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=2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3d5a435bcb168cad644c17c001990a31d1b818d9 program finished with exit code 0 elapsedTime=0.004666 script_repo_revision: '3d5a435bcb168cad644c17c001990a31d1b818d9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.976906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.980235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 15:30:37.991773) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-01 15:30:37.992056) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:30:38 INFO - MultiFileLogger online at 20160301 15:30:38 in /builds/slave/test-pgo 15:30:38 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 15:30:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:30:38 INFO - {'append_to_log': False, 15:30:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:30:38 INFO - 'blob_upload_branch': 'Fx-Team', 15:30:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:30:38 INFO - 'branch': 'Fx-Team', 15:30:38 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:38 INFO - 'config_files': ('talos/linux_config.py',), 15:30:38 INFO - 'default_actions': ('clobber', 15:30:38 INFO - 'read-buildbot-config', 15:30:38 INFO - 'download-and-extract', 15:30:38 INFO - 'populate-webroot', 15:30:38 INFO - 'create-virtualenv', 15:30:38 INFO - 'install', 15:30:38 INFO - 'run-tests'), 15:30:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:38 INFO - 'download_minidump_stackwalk': True, 15:30:38 INFO - 'download_symbols': 'ondemand', 15:30:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:38 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:38 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:38 INFO - 'installer_path': 'installer.exe', 15:30:38 INFO - 'log_level': 'info', 15:30:38 INFO - 'log_name': 'talos', 15:30:38 INFO - 'log_to_console': True, 15:30:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:30:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:30:38 INFO - 'opt_config_files': (), 15:30:38 INFO - 'pip_index': False, 15:30:38 INFO - 'sps_profile': False, 15:30:38 INFO - 'sps_profile_interval': 0, 15:30:38 INFO - 'suite': 'dromaeojs-e10s', 15:30:38 INFO - 'system_bits': '32', 15:30:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:38 INFO - 'title': 'talos-linux64-ix-012', 15:30:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:38 INFO - 'use_talos_json': True, 15:30:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:30:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:38 INFO - 'work_dir': 'build'} 15:30:38 INFO - ##### 15:30:38 INFO - ##### Running clobber step. 15:30:38 INFO - ##### 15:30:38 INFO - Running pre-action listener: _resource_record_pre_action 15:30:38 INFO - Running main action method: clobber 15:30:38 INFO - rmtree: /builds/slave/test-pgo/build 15:30:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:30:39 INFO - Running post-action listener: _resource_record_post_action 15:30:39 INFO - ##### 15:30:39 INFO - ##### Running read-buildbot-config step. 15:30:39 INFO - ##### 15:30:39 INFO - Running pre-action listener: _resource_record_pre_action 15:30:39 INFO - Running main action method: read_buildbot_config 15:30:39 INFO - Using buildbot properties: 15:30:39 INFO - { 15:30:39 INFO - "project": "", 15:30:39 INFO - "product": "firefox", 15:30:39 INFO - "script_repo_revision": "production", 15:30:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:30:39 INFO - "repository": "", 15:30:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 15:30:39 INFO - "buildid": "20160301113318", 15:30:39 INFO - "pgo_build": "True", 15:30:39 INFO - "basedir": "/builds/slave/test-pgo", 15:30:39 INFO - "buildnumber": 209, 15:30:39 INFO - "slavename": "talos-linux64-ix-012", 15:30:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:30:39 INFO - "platform": "ubuntu64_hw", 15:30:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:30:39 INFO - "branch": "fx-team", 15:30:39 INFO - "repo_path": "integration/fx-team", 15:30:39 INFO - "revision": "3d5a435bcb168cad644c17c001990a31d1b818d9", 15:30:39 INFO - "stage_platform": "linux64-pgo", 15:30:39 INFO - "builduid": "f4fefbacc2834bb89e04f563937b2d66", 15:30:39 INFO - "slavebuilddir": "test" 15:30:39 INFO - } 15:30:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 15:30:39 INFO - Running post-action listener: _resource_record_post_action 15:30:39 INFO - ##### 15:30:39 INFO - ##### Running download-and-extract step. 15:30:39 INFO - ##### 15:30:39 INFO - Running pre-action listener: _resource_record_pre_action 15:30:39 INFO - Running main action method: download_and_extract 15:30:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:30: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')]} 15:30:39 INFO - https://queue.taskcluster.net/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:30:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:30:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:30:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:30:41 INFO - Downloaded 1448 bytes. 15:30:41 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:30:41 INFO - Using the following test package requirements: 15:30:41 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:41 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:30:41 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:30:41 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:41 INFO - u'jsshell-linux-x86_64.zip'], 15:30:41 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:30:41 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:41 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:30:41 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:30:41 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:30:41 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:41 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:30:41 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:41 INFO - https://queue.taskcluster.net/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:30:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:30:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:30:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/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 15:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/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 15:31:28 INFO - Downloaded 23391726 bytes. 15:31:28 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'] 15:31:28 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 15:31:29 INFO - Return code: 0 15:31:29 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 15:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:29 INFO - https://queue.taskcluster.net/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/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 15:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/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 15:31:30 INFO - Downloaded 23391726 bytes. 15:31:30 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'] 15:31:30 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 15:31:32 INFO - Return code: 0 15:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:32 INFO - https://queue.taskcluster.net/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/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 15:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/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 15:31:33 INFO - Downloaded 10713413 bytes. 15:31:33 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'] 15:31:33 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 15:31:33 INFO - Return code: 0 15:31:33 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')]} 15:31:33 INFO - https://queue.taskcluster.net/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/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 15:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfVzs89yTKuFsIGegPEp3A/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 15:31:36 INFO - Downloaded 56160094 bytes. 15:31:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:31:36 INFO - mkdir: /builds/slave/test-pgo/properties 15:31:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:31:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:31:36 INFO - Contents: 15:31:36 INFO - build_url:https://queue.taskcluster.net/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:31:36 INFO - Running post-action listener: _resource_record_post_action 15:31:36 INFO - Running post-action listener: set_extra_try_arguments 15:31:36 INFO - ##### 15:31:36 INFO - ##### Running populate-webroot step. 15:31:36 INFO - ##### 15:31:36 INFO - Running pre-action listener: _resource_record_pre_action 15:31:36 INFO - Running main action method: populate_webroot 15:31:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:31:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:31:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:31:36 INFO - '--tppagecycles', 15:31:36 INFO - '7'], 15:31:36 INFO - 'tests': ['tsvgm']}}, 15:31:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:31:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:31:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:31:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:31:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:31:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:31:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'talos_options': ['--e10s'], 15:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'tests': ['damp', 'tps']}, 15:31:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'talos_options': ['--e10s'], 15:31:36 INFO - 'tests': ['damp', 'tps']}, 15:31:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:31:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:31:36 INFO - 'other': {'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore']}, 15:31:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:31:36 INFO - 'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore']}, 15:31:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:31:36 INFO - 'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore']}, 15:31:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:31:36 INFO - 'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore']}, 15:31:36 INFO - 'other_l64': {'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore']}, 15:31:36 INFO - 'other_nol64': {'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore']}, 15:31:36 INFO - 'svgr': {'tests': ['tsvgx', 15:31:36 INFO - 'tsvgr_opacity', 15:31:36 INFO - 'tart', 15:31:36 INFO - 'tscrollx', 15:31:36 INFO - 'cart']}, 15:31:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:31:36 INFO - 'tests': ['tsvgx', 15:31:36 INFO - 'tsvgr_opacity', 15:31:36 INFO - 'tart', 15:31:36 INFO - 'tscrollx', 15:31:36 INFO - 'cart']}, 15:31:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'tests': ['tp5o']}, 15:31:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'talos_options': ['--e10s'], 15:31:36 INFO - 'tests': ['tp5o']}, 15:31:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'talos_options': ['--xperf_path', 15:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:36 INFO - 'tests': ['tp5n']}, 15:31:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'talos_options': ['--e10s', 15:31:36 INFO - '--xperf_path', 15:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:36 INFO - 'tests': ['tp5n']}}, 15:31:36 INFO - 'talos.zip': {'path': '', 15:31:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:31:36 INFO - Running post-action listener: _resource_record_post_action 15:31:36 INFO - ##### 15:31:36 INFO - ##### Running create-virtualenv step. 15:31:36 INFO - ##### 15:31:36 INFO - Running pre-action listener: _resource_record_pre_action 15:31:36 INFO - Running main action method: create_virtualenv 15:31:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:31:36 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 15:31:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:31:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:31:37 INFO - Using real prefix '/usr' 15:31:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:31:37 INFO - Installing distribute.............................................................................................................................................................................................done. 15:31:39 INFO - Installing pip.................done. 15:31:39 INFO - Return code: 0 15:31:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:31: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')]} 15:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:39 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 0x7fb19d61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10348c0>, '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 0x10357c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', '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 15:31:39 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 15:31:39 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 15:31:39 INFO - Using env: {'DISPLAY': ':0', 15:31:39 INFO - 'HOME': '/home/cltbld', 15:31:39 INFO - 'LANG': 'en_US.UTF-8', 15:31:39 INFO - 'LANGUAGE': 'en_US:en', 15:31:39 INFO - 'LOGNAME': 'cltbld', 15:31:39 INFO - 'MAIL': '/var/mail/cltbld', 15:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:39 INFO - 'MOZ_NO_REMOTE': '1', 15:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:39 INFO - 'NO_EM_RESTART': '1', 15:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:31:39 INFO - 'PWD': '/builds/slave/test-pgo', 15:31:39 INFO - 'SHELL': '/bin/bash', 15:31:39 INFO - 'SHLVL': '1', 15:31:39 INFO - 'TERM': 'linux', 15:31:39 INFO - 'TMOUT': '86400', 15:31:39 INFO - 'USER': 'cltbld', 15:31:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', 15:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:39 INFO - '_': '/tools/buildbot/bin/python'} 15:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:39 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 15:31:39 INFO - Cleaning up... 15:31:39 INFO - Return code: 0 15:31:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:31: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')]} 15:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:39 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 0x7fb19d61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10348c0>, '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 0x10357c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', '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 15:31:39 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 15:31:39 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 15:31:39 INFO - Using env: {'DISPLAY': ':0', 15:31:39 INFO - 'HOME': '/home/cltbld', 15:31:39 INFO - 'LANG': 'en_US.UTF-8', 15:31:39 INFO - 'LANGUAGE': 'en_US:en', 15:31:39 INFO - 'LOGNAME': 'cltbld', 15:31:39 INFO - 'MAIL': '/var/mail/cltbld', 15:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:39 INFO - 'MOZ_NO_REMOTE': '1', 15:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:39 INFO - 'NO_EM_RESTART': '1', 15:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:31:39 INFO - 'PWD': '/builds/slave/test-pgo', 15:31:39 INFO - 'SHELL': '/bin/bash', 15:31:39 INFO - 'SHLVL': '1', 15:31:39 INFO - 'TERM': 'linux', 15:31:39 INFO - 'TMOUT': '86400', 15:31:39 INFO - 'USER': 'cltbld', 15:31:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', 15:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:39 INFO - '_': '/tools/buildbot/bin/python'} 15:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:39 INFO - Downloading/unpacking psutil>=0.7.1 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:41 INFO - Installing collected packages: psutil 15:31:41 INFO - Running setup.py install for psutil 15:31:41 INFO - building 'psutil._psutil_linux' extension 15:31:41 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 15:31:42 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 15:31:42 INFO - building 'psutil._psutil_posix' extension 15:31:42 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 15:31:42 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 15:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:42 INFO - Successfully installed psutil 15:31:42 INFO - Cleaning up... 15:31:42 INFO - Return code: 0 15:31:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:42 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 0x7fb19d61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10348c0>, '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 0x10357c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', '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 15:31:42 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 15:31:42 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 15:31:42 INFO - Using env: {'DISPLAY': ':0', 15:31:42 INFO - 'HOME': '/home/cltbld', 15:31:42 INFO - 'LANG': 'en_US.UTF-8', 15:31:42 INFO - 'LANGUAGE': 'en_US:en', 15:31:42 INFO - 'LOGNAME': 'cltbld', 15:31:42 INFO - 'MAIL': '/var/mail/cltbld', 15:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:42 INFO - 'MOZ_NO_REMOTE': '1', 15:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:42 INFO - 'NO_EM_RESTART': '1', 15:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:31:42 INFO - 'PWD': '/builds/slave/test-pgo', 15:31:42 INFO - 'SHELL': '/bin/bash', 15:31:42 INFO - 'SHLVL': '1', 15:31:42 INFO - 'TERM': 'linux', 15:31:42 INFO - 'TMOUT': '86400', 15:31:42 INFO - 'USER': 'cltbld', 15:31:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', 15:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:42 INFO - '_': '/tools/buildbot/bin/python'} 15:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:31:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:31:44 INFO - Installing collected packages: mozsystemmonitor 15:31:44 INFO - Running setup.py install for mozsystemmonitor 15:31:44 INFO - Successfully installed mozsystemmonitor 15:31:44 INFO - Cleaning up... 15:31:44 INFO - Return code: 0 15:31:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb19d61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10348c0>, '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 0x10357c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', '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 15:31:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:31:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:31:44 INFO - Using env: {'DISPLAY': ':0', 15:31:44 INFO - 'HOME': '/home/cltbld', 15:31:44 INFO - 'LANG': 'en_US.UTF-8', 15:31:44 INFO - 'LANGUAGE': 'en_US:en', 15:31:44 INFO - 'LOGNAME': 'cltbld', 15:31:44 INFO - 'MAIL': '/var/mail/cltbld', 15:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:44 INFO - 'MOZ_NO_REMOTE': '1', 15:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:44 INFO - 'NO_EM_RESTART': '1', 15:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:31:44 INFO - 'PWD': '/builds/slave/test-pgo', 15:31:44 INFO - 'SHELL': '/bin/bash', 15:31:44 INFO - 'SHLVL': '1', 15:31:44 INFO - 'TERM': 'linux', 15:31:44 INFO - 'TMOUT': '86400', 15:31:44 INFO - 'USER': 'cltbld', 15:31:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', 15:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:44 INFO - '_': '/tools/buildbot/bin/python'} 15:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:44 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:46 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:31:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:47 INFO - Downloading docopt-0.6.1.tar.gz 15:31:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:47 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:47 INFO - Running setup.py install for blobuploader 15:31:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:31:47 INFO - Running setup.py install for requests 15:31:47 INFO - Running setup.py install for docopt 15:31:47 INFO - Successfully installed blobuploader requests docopt 15:31:47 INFO - Cleaning up... 15:31:48 INFO - Return code: 0 15:31:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:31: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')]} 15:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:48 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 0x7fb19d61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10348c0>, '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 0x10357c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', '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 15:31:48 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 15:31:48 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 15:31:48 INFO - Using env: {'DISPLAY': ':0', 15:31:48 INFO - 'HOME': '/home/cltbld', 15:31:48 INFO - 'LANG': 'en_US.UTF-8', 15:31:48 INFO - 'LANGUAGE': 'en_US:en', 15:31:48 INFO - 'LOGNAME': 'cltbld', 15:31:48 INFO - 'MAIL': '/var/mail/cltbld', 15:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:48 INFO - 'MOZ_NO_REMOTE': '1', 15:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:48 INFO - 'NO_EM_RESTART': '1', 15:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:31:48 INFO - 'PWD': '/builds/slave/test-pgo', 15:31:48 INFO - 'SHELL': '/bin/bash', 15:31:48 INFO - 'SHLVL': '1', 15:31:48 INFO - 'TERM': 'linux', 15:31:48 INFO - 'TMOUT': '86400', 15:31:48 INFO - 'USER': 'cltbld', 15:31:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', 15:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:48 INFO - '_': '/tools/buildbot/bin/python'} 15:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:31:48 INFO - Running setup.py (path:/tmp/pip-cBIg3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:31:48 INFO - Running setup.py (path:/tmp/pip-QLlZtf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:31:48 INFO - Running setup.py (path:/tmp/pip-laHmJV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:31:48 INFO - Running setup.py (path:/tmp/pip-s7REyI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:31:48 INFO - Running setup.py (path:/tmp/pip-Fzn6u0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:31:48 INFO - Running setup.py (path:/tmp/pip-U0e6ck-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:31:48 INFO - Running setup.py (path:/tmp/pip-6KJUp_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:31:48 INFO - Running setup.py (path:/tmp/pip-7rwgXY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:31:48 INFO - Running setup.py (path:/tmp/pip-XIoht5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:31:48 INFO - Running setup.py (path:/tmp/pip-6OCMec-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:31:48 INFO - Running setup.py (path:/tmp/pip-3zLPcJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:31:49 INFO - Running setup.py (path:/tmp/pip-gCPgft-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:31:49 INFO - Running setup.py (path:/tmp/pip-eY6lGQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:31:49 INFO - Running setup.py (path:/tmp/pip-glpBtd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:31:49 INFO - Running setup.py (path:/tmp/pip-mOEjNA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:31:49 INFO - Running setup.py (path:/tmp/pip-u0B9hs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:31:49 INFO - Running setup.py (path:/tmp/pip-lm3crE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:31:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:49 INFO - Running setup.py install for manifestparser 15:31:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:31:49 INFO - Running setup.py install for mozcrash 15:31:49 INFO - Running setup.py install for mozdebug 15:31:49 INFO - Running setup.py install for mozdevice 15:31:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:31:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:31:49 INFO - Running setup.py install for mozfile 15:31:49 INFO - Running setup.py install for mozhttpd 15:31:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Running setup.py install for mozinfo 15:31:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Running setup.py install for mozInstall 15:31:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Running setup.py install for mozleak 15:31:50 INFO - Running setup.py install for mozlog 15:31:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Running setup.py install for moznetwork 15:31:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Running setup.py install for mozprocess 15:31:50 INFO - Running setup.py install for mozprofile 15:31:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Running setup.py install for mozrunner 15:31:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:31:50 INFO - Running setup.py install for mozscreenshot 15:31:51 INFO - Running setup.py install for moztest 15:31:51 INFO - Running setup.py install for mozversion 15:31:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:31:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:51 INFO - Cleaning up... 15:31:51 INFO - Return code: 0 15:31:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:31:51 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')]} 15:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:51 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')]} 15:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:51 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 0x7fb19d61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10348c0>, '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 0x10357c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', '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 15:31:51 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 15:31:51 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 15:31:51 INFO - Using env: {'DISPLAY': ':0', 15:31:51 INFO - 'HOME': '/home/cltbld', 15:31:51 INFO - 'LANG': 'en_US.UTF-8', 15:31:51 INFO - 'LANGUAGE': 'en_US:en', 15:31:51 INFO - 'LOGNAME': 'cltbld', 15:31:51 INFO - 'MAIL': '/var/mail/cltbld', 15:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:51 INFO - 'MOZ_NO_REMOTE': '1', 15:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:51 INFO - 'NO_EM_RESTART': '1', 15:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:31:51 INFO - 'PWD': '/builds/slave/test-pgo', 15:31:51 INFO - 'SHELL': '/bin/bash', 15:31:51 INFO - 'SHLVL': '1', 15:31:51 INFO - 'TERM': 'linux', 15:31:51 INFO - 'TMOUT': '86400', 15:31:51 INFO - 'USER': 'cltbld', 15:31:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', 15:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:51 INFO - '_': '/tools/buildbot/bin/python'} 15:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:31:51 INFO - Running setup.py (path:/tmp/pip-yYmc4Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:31:51 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)) 15:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:31:51 INFO - Running setup.py (path:/tmp/pip-uTwMko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:31:51 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)) 15:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:31:51 INFO - Running setup.py (path:/tmp/pip-9Ymug0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:31:51 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)) 15:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:31:51 INFO - Running setup.py (path:/tmp/pip-8BntyA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:31:51 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)) 15:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:31:51 INFO - Running setup.py (path:/tmp/pip-6WuzNJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:31:51 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)) 15:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:31:51 INFO - Running setup.py (path:/tmp/pip-1YyE_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:31:51 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)) 15:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:31:51 INFO - Running setup.py (path:/tmp/pip-YrPHlt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:31:51 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)) 15:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:31:51 INFO - Running setup.py (path:/tmp/pip-POdXvM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:31:52 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)) 15:31:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:31:52 INFO - Running setup.py (path:/tmp/pip-c3rVQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:31:52 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)) 15:31:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:31:52 INFO - Running setup.py (path:/tmp/pip-HNx1Qh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:31:52 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)) 15:31:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:31:52 INFO - Running setup.py (path:/tmp/pip-C8nMKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:31:52 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)) 15:31:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:31:52 INFO - Running setup.py (path:/tmp/pip-FMyMS_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:31:52 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)) 15:31:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:31:52 INFO - Running setup.py (path:/tmp/pip-QqUmto-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:31:52 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)) 15:31:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:31:52 INFO - Running setup.py (path:/tmp/pip-Wwt_6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:31:52 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)) 15:31:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:31:52 INFO - Running setup.py (path:/tmp/pip-TjCsnA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:31:52 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)) 15:31:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:31:52 INFO - Running setup.py (path:/tmp/pip-wfoiBp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:31:52 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)) 15:31:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:31:52 INFO - Running setup.py (path:/tmp/pip-Rb6bdq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:31:52 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)) 15:31:52 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)) 15:31:52 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)) 15:31:52 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)) 15:31:52 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)) 15:31:52 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)) 15:31:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31:54 INFO - Downloading blessings-1.6.tar.gz 15:31:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:54 INFO - Installing collected packages: blessings 15:31:54 INFO - Running setup.py install for blessings 15:31:54 INFO - Successfully installed blessings 15:31:54 INFO - Cleaning up... 15:31:54 INFO - Return code: 0 15:31:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:31:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:31:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:31:55 INFO - Reading from file tmpfile_stdout 15:31:55 INFO - Current package versions: 15:31:55 INFO - argparse == 1.2.1 15:31:55 INFO - blessings == 1.6 15:31:55 INFO - blobuploader == 1.2.4 15:31:55 INFO - docopt == 0.6.1 15:31:55 INFO - manifestparser == 1.1 15:31:55 INFO - mozInstall == 1.12 15:31:55 INFO - mozcrash == 0.16 15:31:55 INFO - mozdebug == 0.1 15:31:55 INFO - mozdevice == 0.48 15:31:55 INFO - mozfile == 1.2 15:31:55 INFO - mozhttpd == 0.7 15:31:55 INFO - mozinfo == 0.9 15:31:55 INFO - mozleak == 0.1 15:31:55 INFO - mozlog == 3.1 15:31:55 INFO - moznetwork == 0.27 15:31:55 INFO - mozprocess == 0.22 15:31:55 INFO - mozprofile == 0.28 15:31:55 INFO - mozrunner == 6.11 15:31:55 INFO - mozscreenshot == 0.1 15:31:55 INFO - mozsystemmonitor == 0.0 15:31:55 INFO - moztest == 0.7 15:31:55 INFO - mozversion == 1.4 15:31:55 INFO - psutil == 3.1.1 15:31:55 INFO - requests == 1.2.3 15:31:55 INFO - wsgiref == 0.1.2 15:31:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:31:55 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')]} 15:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:55 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')]} 15:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:55 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 0x7fb19d61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10348c0>, '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 0x10357c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', '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 15:31:55 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 15:31:55 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 15:31:55 INFO - Using env: {'DISPLAY': ':0', 15:31:55 INFO - 'HOME': '/home/cltbld', 15:31:55 INFO - 'LANG': 'en_US.UTF-8', 15:31:55 INFO - 'LANGUAGE': 'en_US:en', 15:31:55 INFO - 'LOGNAME': 'cltbld', 15:31:55 INFO - 'MAIL': '/var/mail/cltbld', 15:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:55 INFO - 'MOZ_NO_REMOTE': '1', 15:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:55 INFO - 'NO_EM_RESTART': '1', 15:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:31:55 INFO - 'PWD': '/builds/slave/test-pgo', 15:31:55 INFO - 'SHELL': '/bin/bash', 15:31:55 INFO - 'SHLVL': '1', 15:31:55 INFO - 'TERM': 'linux', 15:31:55 INFO - 'TMOUT': '86400', 15:31:55 INFO - 'USER': 'cltbld', 15:31:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', 15:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:55 INFO - '_': '/tools/buildbot/bin/python'} 15:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:55 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)) 15:31:55 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)) 15:31:55 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)) 15:31:55 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)) 15:31:55 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)) 15:31:55 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)) 15:31:55 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)) 15:31:55 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)) 15:31:55 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)) 15:31:55 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)) 15:31:55 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)) 15:31:55 INFO - Cleaning up... 15:31:55 INFO - Return code: 0 15:31:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:31:55 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')]} 15:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:55 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')]} 15:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:55 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 0x7fb19d61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10348c0>, '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 0x10357c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', '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 15:31:55 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 15:31:55 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 15:31:55 INFO - Using env: {'DISPLAY': ':0', 15:31:55 INFO - 'HOME': '/home/cltbld', 15:31:55 INFO - 'LANG': 'en_US.UTF-8', 15:31:55 INFO - 'LANGUAGE': 'en_US:en', 15:31:55 INFO - 'LOGNAME': 'cltbld', 15:31:55 INFO - 'MAIL': '/var/mail/cltbld', 15:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:55 INFO - 'MOZ_NO_REMOTE': '1', 15:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:55 INFO - 'NO_EM_RESTART': '1', 15:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:31:55 INFO - 'PWD': '/builds/slave/test-pgo', 15:31:55 INFO - 'SHELL': '/bin/bash', 15:31:55 INFO - 'SHLVL': '1', 15:31:55 INFO - 'TERM': 'linux', 15:31:55 INFO - 'TMOUT': '86400', 15:31:55 INFO - 'USER': 'cltbld', 15:31:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', 15:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:55 INFO - '_': '/tools/buildbot/bin/python'} 15:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:55 INFO - Downloading/unpacking jsonschema 15:31:55 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 15:31:55 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 15:31:55 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 15:31:55 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 15:31:55 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 15:31:55 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 15:31:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:57 INFO - Downloading/unpacking functools32 (from jsonschema) 15:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:57 INFO - warning: no files found matching '*.txt' 15:31:57 INFO - no previously-included directories found matching 'build' 15:31:57 INFO - no previously-included directories found matching 'dist' 15:31:57 INFO - no previously-included directories found matching '.git*' 15:31:57 INFO - Installing collected packages: jsonschema, functools32 15:31:57 INFO - Running setup.py install for functools32 15:31:57 INFO - warning: no files found matching '*.txt' 15:31:57 INFO - no previously-included directories found matching 'build' 15:31:57 INFO - no previously-included directories found matching 'dist' 15:31:57 INFO - no previously-included directories found matching '.git*' 15:31:57 INFO - Successfully installed jsonschema functools32 15:31:57 INFO - Cleaning up... 15:31:57 INFO - Return code: 0 15:31:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:31: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')]} 15:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:57 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 0x7fb19d61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10348c0>, '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 0x10357c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', '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 15:31:57 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 15:31:57 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 15:31:57 INFO - Using env: {'DISPLAY': ':0', 15:31:57 INFO - 'HOME': '/home/cltbld', 15:31:57 INFO - 'LANG': 'en_US.UTF-8', 15:31:57 INFO - 'LANGUAGE': 'en_US:en', 15:31:57 INFO - 'LOGNAME': 'cltbld', 15:31:57 INFO - 'MAIL': '/var/mail/cltbld', 15:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:57 INFO - 'MOZ_NO_REMOTE': '1', 15:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:57 INFO - 'NO_EM_RESTART': '1', 15:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:31:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:31:57 INFO - 'SHELL': '/bin/bash', 15:31:57 INFO - 'SHLVL': '1', 15:31:57 INFO - 'TERM': 'linux', 15:31:57 INFO - 'TMOUT': '86400', 15:31:57 INFO - 'USER': 'cltbld', 15:31:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', 15:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:57 INFO - '_': '/tools/buildbot/bin/python'} 15:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:57 INFO - Downloading/unpacking flake8 15:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:31:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:31:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:32:00 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 15:32:00 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 15:32:00 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 15:32:00 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 15:32:00 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 15:32:00 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 15:32:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:32:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:32:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:32:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:32:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:32:00 INFO - no previously-included directories found matching 'docs/_build' 15:32:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:32:00 INFO - Running setup.py install for pep8 15:32:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:32:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:32:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:32:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:32:00 INFO - no previously-included directories found matching 'docs/_build' 15:32:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:32:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:32:00 INFO - Cleaning up... 15:32:00 INFO - Return code: 0 15:32:00 INFO - Running post-action listener: _resource_record_post_action 15:32:00 INFO - Running post-action listener: _start_resource_monitoring 15:32:00 INFO - Starting resource monitoring. 15:32:00 INFO - ##### 15:32:00 INFO - ##### Running install step. 15:32:00 INFO - ##### 15:32:00 INFO - Running pre-action listener: _resource_record_pre_action 15:32:00 INFO - Running main action method: install 15:32:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:32:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:32:00 INFO - Reading from file tmpfile_stdout 15:32:00 INFO - Detecting whether we're running mozinstall >=1.0... 15:32:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:32:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:32:01 INFO - Reading from file tmpfile_stdout 15:32:01 INFO - Output received: 15:32:01 INFO - Usage: mozinstall [options] installer 15:32:01 INFO - Options: 15:32:01 INFO - -h, --help show this help message and exit 15:32:01 INFO - -d DEST, --destination=DEST 15:32:01 INFO - Directory to install application into. [default: 15:32:01 INFO - "/builds/slave/test-pgo"] 15:32:01 INFO - --app=APP Application being installed. [default: firefox] 15:32:01 INFO - mkdir: /builds/slave/test-pgo/build/application 15:32:01 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'] 15:32:01 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 15:32:17 INFO - Reading from file tmpfile_stdout 15:32:17 INFO - Output received: 15:32:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:32:17 INFO - Running post-action listener: _resource_record_post_action 15:32:17 INFO - ##### 15:32:17 INFO - ##### Running run-tests step. 15:32:17 INFO - ##### 15:32:17 INFO - Running pre-action listener: _resource_record_pre_action 15:32:17 INFO - Running main action method: run_tests 15:32:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:32:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:32:17 INFO - Python 2.7.3 15:32:17 INFO - Return code: 0 15:32:17 INFO - grabbing minidump binary from tooltool 15:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:17 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 0x10348c0>, '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 0x10357c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:32:17 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 15:32:17 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 15:32:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:32:17 INFO - Return code: 0 15:32:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:32:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:32:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:32:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:32:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:32:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:32:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:32:18 INFO - Return code: 0 15:32:18 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/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 15:32:18 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/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 15:32:18 INFO - Using env: {'DISPLAY': ':0', 15:32:18 INFO - 'HOME': '/home/cltbld', 15:32:18 INFO - 'LANG': 'en_US.UTF-8', 15:32:18 INFO - 'LANGUAGE': 'en_US:en', 15:32:18 INFO - 'LOGNAME': 'cltbld', 15:32:18 INFO - 'MAIL': '/var/mail/cltbld', 15:32:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:32:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:18 INFO - 'MOZ_NO_REMOTE': '1', 15:32:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:18 INFO - 'NO_EM_RESTART': '1', 15:32:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:32:18 INFO - 'PWD': '/builds/slave/test-pgo', 15:32:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:32:18 INFO - 'SHELL': '/bin/bash', 15:32:18 INFO - 'SHLVL': '1', 15:32:18 INFO - 'TERM': 'linux', 15:32:18 INFO - 'TMOUT': '86400', 15:32:18 INFO - 'USER': 'cltbld', 15:32:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132', 15:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:18 INFO - '_': '/tools/buildbot/bin/python'} 15:32:18 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/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 15:32:18 INFO - mozversion application_buildid: 20160301113318 15:32:18 INFO - mozversion application_changeset: 3d5a435bcb168cad644c17c001990a31d1b818d9 15:32:18 INFO - mozversion application_display_name: Nightly 15:32:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:32:18 INFO - mozversion application_name: Firefox 15:32:18 INFO - mozversion application_remotingname: firefox 15:32:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:32:18 INFO - mozversion application_vendor: Mozilla 15:32:18 INFO - mozversion application_version: 47.0a1 15:32:18 INFO - mozversion platform_buildid: 20160301113318 15:32:18 INFO - mozversion platform_changeset: 3d5a435bcb168cad644c17c001990a31d1b818d9 15:32:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:32:18 INFO - mozversion platform_version: 47.0a1 15:32:18 INFO - using testdate: 1456875138 15:32:18 INFO - actual date: 1456875138 15:32:18 INFO - starting webserver on 'localhost:35989' 15:32:18 INFO - SUITE-START | Running 2 tests 15:32:18 INFO - TEST-START | dromaeo_css 15:32:18 INFO - operating with platform_type : linux_ 15:32:18 INFO - Initialising browser for dromaeo_css test... 15:32:18 INFO - TEST-INFO | started process 14519 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCkpxOM/profile http://localhost:35989/getInfo.html) 15:32:21 INFO - PROCESS | 14519 | 15:32:21 INFO - PROCESS | 14519 | (process:14602): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:32:22 INFO - PROCESS | 14519 | __metrics Screen width/height:1600/1200 15:32:22 INFO - PROCESS | 14519 | colorDepth:24 15:32:22 INFO - PROCESS | 14519 | Browser inner width/height: 1024/697 15:32:22 INFO - PROCESS | 14519 | __metrics 15:32:22 ERROR - PROCESS | 14519 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:32:22 INFO - PROCESS | 14519 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:32:22 INFO - PROCESS | 14519 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:32:22 INFO - PROCESS | 14519 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:32:22 INFO - PROCESS | 14519 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:32:22 INFO - PROCESS | 14519 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:32:22 INFO - PROCESS | 14519 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:32:22 INFO - PROCESS | 14519 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:32:22 INFO - PROCESS | 14519 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:32:22 INFO - PROCESS | 14519 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:32:23 INFO - TEST-INFO | 14519: exit 0 15:32:23 INFO - Browser initialized. 15:32:23 INFO - Running cycle 1/1 for dromaeo_css test... 15:32:23 INFO - TEST-INFO | started process 14653 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCkpxOM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:25 INFO - PROCESS | 14653 | 15:32:25 INFO - PROCESS | 14653 | (process:14712): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:32:35 INFO - PROCESS | 14653 | RSS: Main: 160403456 15:32:35 INFO - PROCESS | 14653 | 15:33:25 INFO - PROCESS | 14653 | 1456875205164 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] 15:35:33 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:35989/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35989/tests/dromaeo/cssquery-ext.html) 15:35:34 INFO - PROCESS | 14653 | RSS: Main: 168542208 15:35:34 INFO - PROCESS | 14653 | 15:38:36 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:35989/tests/dromaeo/cssquery-ext.html (next: http://localhost:35989/tests/dromaeo/cssquery-jquery.html) 15:38:36 INFO - PROCESS | 14653 | RSS: Main: 165396480 15:38:36 INFO - PROCESS | 14653 | 15:41:38 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:35989/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35989/tests/dromaeo/cssquery-mootools.html) 15:41:39 INFO - PROCESS | 14653 | RSS: Main: 166797312 15:41:39 INFO - PROCESS | 14653 | 15:44:40 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:35989/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35989/tests/dromaeo/cssquery-prototype.html) 15:44:41 INFO - PROCESS | 14653 | RSS: Main: 164818944 15:44:41 INFO - PROCESS | 14653 | 15:47:43 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:35989/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35989/tests/dromaeo/cssquery-yui.html) 15:47:44 INFO - PROCESS | 14653 | RSS: Main: 165511168 15:47:44 INFO - PROCESS | 14653 | 15:50:46 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:35989/tests/dromaeo/cssquery-yui.html (next: http://localhost:35989/tests/dromaeo/cssquery-dojo.html) 15:50:47 INFO - PROCESS | 14653 | RSS: Main: 168394752 15:50:47 INFO - PROCESS | 14653 | 15:50:47 INFO - PROCESS | 14653 | __start_tp_report 15:50:47 INFO - PROCESS | 14653 | _x_x_mozilla_page_load 15:50:47 INFO - PROCESS | 14653 | _x_x_mozilla_page_load_details 15:50:47 INFO - PROCESS | 14653 | |i|pagename|runs| 15:50:47 INFO - PROCESS | 14653 | |0;dojo.html;3220.5813244278247;3221.4040402525534;3246.155999440145;3268.7548433867464;3277.1970867137557;5211.8697032574155;5232.921506177406;5272.182811664188;5282.102042652748;5300.416954135042;5323.866903327419;5384.730763461831;5390.6226564140525;5448.891022179554;5449.782008719656;4923.212286034244;4939.851804445872;4997.250412438145;5026.597872170236;5095.108356037697;240.47110882658595;4943.8516844494725;4977.875553111165;4984.950150498485;5010.448850626446;4953.752312384402;4964.329815474919;4983.252512123192;5011.273365362039;5041.395032596075;4885.804567817283;4954.975225123887;4961;5017.147084995559;5063.974680126613;4883.902321953541;4916.385451818523;4937.901241975141;4951.183054795954;4985.651004429691;5153.201253805666;5230.712310822903;5247.737613119329;5275.28783614211;5281.102212623863;5668.064769313059;5775.740091695884;5803.9709801451145;5826.213461182729;5848.88302233953;5831.854203644943;5857.033589457735;5857.297124345063;5862.589618726691;5902.2032025676845;5382.192671099367;5441.347038355383;5460.290162278918;5461.044317244467;5470.206820011116;5850.444207800252;5918.940810591839;5927.525797936155;5940.762369505258;5941.792037278675;5770.653760774367;5773.653580785166;5782.479576838105;5783.624064435799;5783.652980821164;5819.767209311664;5835.212246346774;5855.619384739978;5861.003629383015;5871.148683440877;5611.8597035073635;5760.94239057604;5807.303123625192;5809.2738407699035;5862.208601838783;5688.658680479184;5765.827025189167;5797.884042319214;5800.970995145081;5881.323647780475;4380.518143004267;4385.122975404868;4402.141582391403;4406.9643633746045;4449.866504004885;3940.4877365942816;3943.526776786804;3945.191235796655;3954.9011274717786;4007.8797636070963;5339.839804805862;5391.649542779707;5415.945840541623;5427.050266203399;5457.508824205841;5706.28671416073;5706.315242170883;5732.914006289909;5733.025385684444;5740.712964351766;5379.67721936685;5428.6199966002005;5457.181422786613;5491.2312276281355;5519.862003449865;4916.311716359713;4928.556429921325;4958.950410495849;4962.454130045692;4987.476314986947;6056.364081771439;6068.4538391544975;6072.089186622042;6075.878482430327;6081.604695694766;5668.206451096849;5779.2198053263955;5805.651660900359;5828.397190772572;5835.883282334415;5996;6019.939800601938;6032.909506357496;6034.39656034393;6063.484603808725;5589.692566908859;5717.885642287048;5733.254676891977;5738.598298119092;5755.568332375173;5750.798722044876;5784.942150578609;5785.681787501728;5797.797077102281;5837.824865254049;5639.154126881001;5647.124695672177;5649.830505084854;5653.886922261614;5693;5597.272354593877;5607.214989901336;5643.492085712305;5645.774169033192;5647.745851436613;5427;5452.345718513804;5517.282753242052;5572.192032155396;5614.522765564972;5587.078132108157;5602.607817452739;5612.579056570692;5632.5212356950115;5642.548596112383;5438.564914806885;5457.072297709319;5462.617616766788;5463.235147079333;5492.340919089735 15:50:47 INFO - PROCESS | 14653 | |1;ext.html;502.13381916194567;528.4002656984321;548.9423610520895;556.8273835111113;557.8382269141948;36482.81758591207;36854.63145368549;37029;37102.8144859276;37108.628913710854;39622.405663915066;40269.59730402695;40272.395914061315;40300.59699403005;40331.19337613246;8421.368397370206;8606.354523410739;8626.482411055325;8639.784005399852;8677.609507572175;8380.455270407405;8553.358498112635;8574.69988550401;8574.871376929352;8590.055093939693;8777.912220877804;8786.956065219696;8818.20636142747;8854.86717699235;8859.512726800023;8699.478031318142;8738.30093592511;8756.956215218883;8764.649414023432;8783.868241976375;8620.870686939701;8771.16673915977;8794.824103517894;8815.691450799255;8838.337124715672;41247;41589;41760.79119604383;41764.37353439701;41799.58200418018;3310.2551925816497;3380.9323813523592;3441.9311613767836;3668.248009158116;3939.330313846653;27756.861215693792;27772.58341124885;27938.860305698545;28050.719492805016;28258.29354266139;3888.3972984187494;3925.7840818754958;3968.761874287523;4047.0489434982755;4077.2049450357194;278855;280307;280834.5958270216;281982;282347;56740.758516563146;57440.425595744346;57570.136447953315;57994;58040.12939805906;58352.416475834696;66860.3313966854;68116.318836811;68980.6550967252;69206.65396672985;16034.679306413806;16125.193740312938;16217.59456013609;16239;16280.511584652479;11189.104871610252;11243.60647377338;11251.493682784294;11252.718682033015;11273.830892536618;20112.39662810118;20325.695114573293;20329.593408131754;20512.58974820525;20548;7906;8229.341652667772;8252.628631711588;8266.13205613402;8277.668893244203;942.3780304998668;971.1987610221596;1019.612547232062;1019.8368261078192;1078.2236789511696;28952.710472895422;29015.274618134714;29103;29172.27069323284;29359;1064.2177999170603;1096.6381094238882;1101.300674071954;1149.804533229353;1191.4638412714314;14802.62993425173;14816.555503334917;15062.246887655574;15168.165750883587;15398.384064637288;313540;316367;317883;318085;318190;52692;53727.73136134294;53751;54162;54335;1368.4047439363908;1370.4240123857444;1391.3391139208795;1392.7980442835935;1394.8744612984676;27439;28143.43713125767;28760.568591470725;29090.563641545818;29311.85344073266;47067.76466117647;47363.763181185255;47438;47610.04779904313;47803.28295075507;243569;248207;248222;248681;250035;32463.18842028968;32776.18059548435;32926.83536582302;33043.173920652174;33316.500252495745;44061.118777623626;44473.11053778971;45084;45191.77404112958;45374.31938520991;37295.25409491849;37721.62278377181;38325.61674383332;38497.30518863653;38922.80538597289;37220.6277937228;37268.627313726516;37531.62468375391;37855.242895142495;38223.23553528969;36728.26543469169;37231.627683722814;37915.62084379231;39322.80338598289;39399.212015760095;22969.77030229676;23110.76889231086;23173.53652926966;23675.64486532669;23772.643410349203;24108.1918856083;24111.15610953608;24257.514849702555;25078.62382064307;25078.74921250837 15:50:47 INFO - PROCESS | 14653 | |2;jquery.html;344.97499676896615;352.4448992836282;353.6021975277812;365.78053168099143;366.41190888623777;16475.846690731654;16893.155342232887;17257.654846903053;17269.136543172823;17300.74048889266;16015.439459618916;16290.348386064572;16394.09832459214;16710.916445417788;16741.246643901024;5208.609354298424;5222.16445368742;5387.730613469331;5388;5397.190421436777;5283.6037297202865;5326.041312563756;5330.093884039703;5342.839714808562;5370.0333939891;5110.463401342861;5284.762185701653;5311.282976798141;5314.574834013289;5337.599680023995;5278;5284.867878303035;5292.444293349181;5310.734463276821;5316.069687804618;4580;4705.223638099709;4757.5718185363485;4783.736894470802;4793.089313030548;20676.689849652266;20696.58606827855;20702.896485517627;20766.79233207664;20989.950502474814;2299.8275129365366;2355.9646605300936;2907.3270817667085;2948.1155653304136;2971.895983640584;13013.609591712264;13350.26573538455;13508.93245533776;13580.524681636096;13698.726025479535;1825.607494388713;1858.4053103007043;1884.6042331110484;1886.7452893859427;1900.9524761880925;56959.43040569583;59709.40290597082;60005.39994600042;62186.689066554376;62955.6852215736;9485;9664.420134791935;9872.062154095349;9883.654072107585;9965.601375944882;12791.360431978364;12840.165389249669;12879;12881.871181288067;12913.677158070936;7462.552246865205;7560.546367217985;7633.931249625057;7722.3049925506975;7736.149023607399;7579.1284002339335;7608.505447145918;7721.884171737428;7742.535447873033;7896.447248692536;4283.186194623012;4329.935050974238;4333.956660433419;4364.563543645673;4383.539728328544;1814.410316647095;1817.554699098703;1853.3698542495347;1865.4496923407628;1895.639828432621;899.6761165980242;956.9473678947586;1015.7141646772684;1016.3444578246989;1018.063381688848;16754.832451675327;17207.311707531808;17354.739678904825;17466.12669366552;17675.292988280326;975.2100798353357;978.8874279457812;1008.6973907827622;1017.1100287248657;1027.6403258859489;9705.64202722369;9931.404115753077;9980.45107519079;10030.097291243823;10084.445355505371;430119;433713;435613;436612;439807;74522;76527.23472765312;76721.23278767141;76749.23250767421;77444.61277693576;1004.2869562610482;1004.4626125023224;1018.923580731448;1030.3508789462592;1040.7658276887792;14528;15212.391504339703;15293.847061529686;15473.148976806384;15571.922140389226;34285.31429371348;34748.13129671779;35263.11842203965;35367;35498.46752298666;43111.35332970071;44119.55880441154;44874.326885096096;45323.32015019711;45520.54479455163;7800.687972481264;7894.644740986554;7910.327622151951;7926.643301051582;8163.469374490639;8772.991106022633;11736.237144585575;12033.4584943676;12155.392230388623;12536.122471426912;10812.297200681931;11025.283356581796;11066.778664426505;11072.501737421997;11118.166137539878;10917;11073.390963496762;11248.212625116163;11319.320840749582;11475.48360323804;10725.678229653124;10736.624218152327;10940.179486538382;11170.944145279222;11291.814359492135;7382.4094072473;7609.885851712118;7734.497257678233;7856.096548896721;8066.435349525477;10308.896911030793;10563.577456901945;10731.463426828783;10846.349219046882;11138.665840024812 15:50:47 INFO - PROCESS | 14653 | |3;mootools.html;1505.1270263247318;1523.0861483110132;1720.5526563093592;1829.6157806860558;1858.953526161845;7812.218778122185;7917.247861453153;8005.599720013998;8021.639026243818;8035.879461808063;8079.151689072636;8111.959440202805;8184;8208.425410221287;8213.671453141867;2255.5263394687136;2276.1578216059997;2293.827962902789;2294.380517260347;2296.5636529059425;2320.791128798408;2328.3364241191266;2369.7985671217966;2370.0875163062174;2378.797802186816;2291.873946932918;2316.027268547214;2341.695579574661;2388.558116748407;2392.7248366437907;2336.556054349685;2346.9530609387803;2356.8821558922073;2358.6344116661944;2372.750861159571;2352.047420794581;2374.2877136858874;2375.750546192642;2375.845570037959;2387.1048356866177;8123.837523249561;8139.308158806509;8141.22658347456;8144.959275203586;8177.918220817775;4673.11210869937;4695.084458530588;4793.2810078488155;4979.30289759434;4984.950150498485;3129.4992801151707;3142.450071237547;3186.0441867439677;3191.0586377018603;3230.095573239497;949.264320151881;958.5925981457922;961.3606951377326;972.042538099971;998.5756053677159;10897.291676041112;11088.279261847954;11120.165987550967;11146.944265278622;11205.439728013649;4205.453291072141;4260.062786187096;4278.122984788111;4303.784810759512;4378.365137055109;8719.171678690514;8726.127387261224;8727.476351418934;8739.169778870997;8782.341324400695;4800;4822.831200908022;4854.660173787872;4871.391076115486;4880.341153944172;4421.071574969228;4480.059187570647;4521.4574251089425;4565.0413413183605;4582.839600614029;3494.7029502492064;3537.5224344713647;3546.3261980223674;3553.431450967833;3566.3045706087582;1016.506994107857;1031.7265924530006;1037.9377237365782;1042.3485321673954;1109.8557187565564;1355.0650051464654;1357.2738584857054;1359.34071975092;1378.1868697468542;1383.75784237758;7498.6625601848045;7652.923470765221;7678.769636910902;7699.615019249015;7700.576468294297;468.9882752931204;476.833108412053;477.7444067423981;481.11474886209544;483.3450674336224;5789.073748200268;5837.270341207349;5853.063509838491;5892.499137573269;5895.764169433261;9427.292953028413;9932.453715045742;9947;10034.397936123856;10104.595816167419;9769.16962058233;9837.508124593742;9881.703548893545;9882.160016398686;9925.454100024424;7499.6250187490405;7598.506097103671;7613.505122167041;7629.04636920396;7723.729669461654;7235.384992275715;7329.340359367682;7377.26227377258;7400.703971841282;7402.29678180572;8186.7953301167945;8852.336074794288;8859.689910853089;9067.410618309788;9092.818143637223;8529.270633397253;8674;8689.478631282143;8798.516081615317;8942.68700595476;6190.566660333733;6679.599224046573;6829.931700683128;7038.859222815618;7116.039334689957;7439.479236453396;7521.548707077593;7547.471676982558;7557.508761930457;7613.162552119373;6655.900161497679;6869.862602747817;6915.377616014583;7018.052562903943;7028.894566581607;6663.13379260693;6685.796556619855;6802.795916122524;6831.59010459374;6896.137982752156;7027.191872934473;7033.331833475811;7043.964780176271;7097.432205423657;7315.48791584584;6617.338266173344;6670.499712521678;6714.227863795726;6725.966370168314;6752.69612867432;6618.503612229006;6668.599884006975;6702.36327548882;6722.630255336004;6735.4274886635185 15:50:47 INFO - PROCESS | 14653 | |4;prototype.html;305.15015681327503;313.1419909448112;323.07278111819085;327.9065466342093;328.93585750778607;6272.56092073555;6282.246130464339;6352.428281454668;6375.330590288023;6394.104825324458;6211.378862113786;6214.130021796952;6223.315435302113;6250.8124756257275;6279.968600156993;4591.265397536403;4714.481407045222;4724.503927087658;4734.763261836912;4736.786844591985;4675.625949924015;4702.130105930414;4705.106029854317;4705.882352941169;4716.245400735883;4664.416947881515;4667.649926255527;4672.042231342567;4672.8598142055625;4674.135284972274;4653.627709783209;4669.229577119771;4672.299155126724;4677.298405239208;4696.506866779007;4007.358822588401;4008.599140085997;4010.418489319062;4016.9598304016877;4025.6175663311938;5868.559858010623;5959.791407300723;6018.759249630009;6024.0662697282;6024.608400453956;5384.838454846361;5403.405625381205;5417.295751552312;5432.049391356497;5437.619366644297;6601.6699165041555;6605.801825945229;6610.471162307004;6622.53642245043;6630.834229144261;4380.34294855771;4401.405810215644;4403;4407.096545208225;4414.84548040817;6872.175338959307;6924.826879328007;6952.791416257521;6958.8956165657555;6966.999999999949;4367.082912588328;4528.547145285445;4529.932051019237;4532.093581283691;4533.184026875128;4494.52807455219;4496.258117410656;4500.459944806578;4503.41455610775;4506.301523263899;5304.761285742151;5326.92009619856;5334.013207556614;5363.302770639792;5364.544013758874;6670.299618540081;6699.296573859772;6711.899321510181;6715.529912906148;6726.529142960044;1576.676781259839;1624.2122570553272;1624.9268782904799;1626.7397216445313;1627.2270671430977;1022.1107636356269;1025.2259544044348;1051.2798732867857;1067.4022547373495;1072.7050061233224;6388.584741991755;6406.423421892052;6419.716056788568;6422.839429014219;6430.807075787734;6867.175938887365;6893.276205998298;6935.133108361455;6936.445084393236;6943.6875340609795;6275.184226050585;6364.1408409865;6429.7749578764515;6466.967665161644;6488.902666460007;3710.128119891823;3724.832382542792;3743.344914639927;3743.5320584926885;3747.4940882980995;7201.3518783309755;7264;7352.448566357544;7385.889211661829;7402.185759566443;7163.140423149255;7187.137543494814;7194.568325900463;7201.063861697946;7201.243869393743;7182.96408517954;7387;7408.259174082548;7460.0674915635545;7461.626918653937;6985.057017302599;7009.754658586925;7010.859782804213;7028.789136325919;7030.472714546328;6832.419244364086;6871.072405225231;6925.272846351262;6925.89611155823;6935.410490108397;7375.668094935633;7391.556506609621;7396.7780966568935;7397.408207343292;7401.0748656417945;4529.252673308867;4642.071585682945;4650.232711602548;4667.719936803803;4675;6760.290169532128;6783.423409010289;6874.828129296808;6884.208316043719;6886.380225779704;6626.469882409299;6668.066470694203;6675.098861653614;6680.665966701743;6688.230853451915;6645.169353830771;6666.866662666623;6676.89984650221;6695.0626912231355;6696.59820410777;6405.775797847053;6541.34586541342;6572.34276572339;6574.638394888327;6589.637569933508;6678.966605166943;6720.731170753115;6725.159355080615;6728.125343705287;6734.552071304693;6501.44737697301;6514.54398192122;6519.4784417245555;6521.054447105238;6540.051692504465 15:50:47 INFO - PROCESS | 14653 | |5;yui.html;786.7561056072618;803.2690251870795;809.7773112394087;832.6128350317103;854.8119413728986;13761.724765504683;13898.583042508715;13898.86101138987;13936.303184840755;13958.162510249393;12736.426860791264;12755.681107972305;12771.80842287364;13395.196288222713;13453.663658408545;699.6606645776794;848.3806821020659;861.0485413617956;864.567716141929;864.9870251946226;848.406115718996;864.394923553512;867.0982178534317;869.6564856881528;869.7129947117436;885.3404213860683;889.3018980100622;893.5800173918248;900.6622516556291;904.430208968349;885.9911400885973;890.8396488632076;895.4492986813128;896.4710820615868;897.8653202019684;655.1712084213474;655.2301046270613;656.0520048529876;656.5108993799649;657.1621182991676;13167.144135631153;13353.13204641705;13381.66545836352;13388.598342049656;13520.12119212248;13291.800622990662;13535.864641353657;13592.320383980761;13615.18308901469;13784.172949623055;10085.546150423248;10321.12270457012;10397;10701.732456688567;10737.141028717684;3604.4593311003296;3639.2357604902736;3662.505561749156;3668.853245870162;3690.7970061646597;49804.50195497998;49897.25154122691;50278.24582631227;50562.49437505614;50588;9569.952150239204;9760;9855.507224638739;9894.950525247328;10075.294729368874;19546.413607591796;19584.412467625993;19597;19610;19716.60566788656;7427.3374866588465;7525.397968162534;7590.962045189849;7750.069991600932;7833.764987050397;4243.342281946303;4280.636145927631;4328.3723860040745;4333.198358303724;4336.76147811867;3196.3926853897683;3206.8556914938886;3225.870965161367;3226.483762597973;3244.7241984431116;557.0891592246705;567.6026781253057;574.8591595059154;577.3331801768963;583.096200888621;530.745242283706;563.1580786723792;619.3651507205151;622.0358444411145;629;8398.454100483448;8455.66177352899;8493.362997775192;8586.203629364049;8619.827603447897;568.8094488346368;637.2607774981;640.546494072215;641.5733537197711;656.9868602627921;3632.6730594246646;3883.689304855605;3895.8831235062994;3910.276598829226;3942.250972315251;54277;54914.45085549093;55067;55387.446125539034;55455.168172477446;49338;49399.75300123476;49693;50946.49053509492;51257.48742512527;43116.56883431188;43240.35139472911;43700.125997479874;44503.77748111239;46579.76710116496;8108.310793582612;8144.429889907649;8203;8251.917480825356;8257.95871020665;33028.66971330256;33407.164820879676;34040.82979585086;34500.30999380049;34941.825290873385;38853.805730971166;39014;42692.57307426886;43556.34665480084;43829.780851095544;11103.833442498531;11226.719332016764;11569.710757231136;11752.294862308288;12008.459619316976;12369.752604948031;12613.558525451564;12621.74756504883;12699.301538415475;13384.063115581816;11061.170412218955;11878.168528202943;11925.82111268349;12239.877601223874;12253.677146306049;11595.942020289845;11852.76294474123;12218.083643726579;12489.18820276679;12496.312702801433;10435.895641043493;11148.665540033811;11314.434278286217;11738.647840564456;11947.223430476992;9082.954585227031;9108.200857183974;9173.724788256362;9313.39462934907;9922.851157232502;8436.789080273042;8490.61792219364;8719.866417365702;9323.72028839136;9831.213502919607 15:50:47 INFO - PROCESS | 14653 | __end_tp_report 15:50:47 INFO - PROCESS | 14653 | __start_cc_report 15:50:47 INFO - PROCESS | 14653 | _x_x_mozilla_cycle_collect,313 15:50:47 INFO - PROCESS | 14653 | __end_cc_report 15:50:47 INFO - PROCESS | 14653 | __startTimestamp1456876247000__endTimestamp 15:50:47 INFO - PROCESS | 14653 | 15:50:47 INFO - PROCESS | 14653 | ------- Summary: start ------- 15:50:47 INFO - PROCESS | 14653 | Number of tests: 6 15:50:47 INFO - PROCESS | 14653 | 15:50:47 INFO - PROCESS | 14653 | [#0] dojo.html Cycles:165 Average:5346.24 Median:5519.86 stddev:717.71 (13.0%) stddev-sans-first:700.27 15:50:47 INFO - PROCESS | 14653 | Values: 3220.6 3221.4 3246.2 3268.8 3277.2 5211.9 5232.9 5272.2 5282.1 5300.4 5323.9 5384.7 5390.6 5448.9 5449.8 4923.2 4939.9 4997.3 5026.6 5095.1 240.5 4943.9 4977.9 4985.0 5010.4 4953.8 4964.3 4983.3 5011.3 5041.4 4885.8 4955.0 4961.0 5017.1 5064.0 4883.9 4916.4 4937.9 4951.2 4985.7 5153.2 5230.7 5247.7 5275.3 5281.1 5668.1 5775.7 5804.0 5826.2 5848.9 5831.9 5857.0 5857.3 5862.6 5902.2 5382.2 5441.3 5460.3 5461.0 5470.2 5850.4 5918.9 5927.5 5940.8 5941.8 5770.7 5773.7 5782.5 5783.6 5783.7 5819.8 5835.2 5855.6 5861.0 5871.1 5611.9 5760.9 5807.3 5809.3 5862.2 5688.7 5765.8 5797.9 5801.0 5881.3 4380.5 4385.1 4402.1 4407.0 4449.9 3940.5 3943.5 3945.2 3954.9 4007.9 5339.8 5391.6 5415.9 5427.1 5457.5 5706.3 5706.3 5732.9 5733.0 5740.7 5379.7 5428.6 5457.2 5491.2 5519.9 4916.3 4928.6 4959.0 4962.5 4987.5 6056.4 6068.5 6072.1 6075.9 6081.6 5668.2 5779.2 5805.7 5828.4 5835.9 5996.0 6019.9 6032.9 6034.4 6063.5 5589.7 5717.9 5733.3 5738.6 5755.6 5750.8 5784.9 5785.7 5797.8 5837.8 5639.2 5647.1 5649.8 5653.9 5693.0 5597.3 5607.2 5643.5 5645.8 5647.7 5427.0 5452.3 5517.3 5572.2 5614.5 5587.1 5602.6 5612.6 5632.5 5642.5 5438.6 5457.1 5462.6 5463.2 5492.3 15:50:47 INFO - PROCESS | 14653 | 15:50:47 INFO - PROCESS | 14653 | [#1] ext.html Cycles:180 Average:45565.89 Median:37281.94 stddev:73990.27 (198.5%) stddev-sans-first:74120.46 15:50:47 INFO - PROCESS | 14653 | Values: 502.1 528.4 548.9 556.8 557.8 36482.8 36854.6 37029.0 37102.8 37108.6 39622.4 40269.6 40272.4 40300.6 40331.2 8421.4 8606.4 8626.5 8639.8 8677.6 8380.5 8553.4 8574.7 8574.9 8590.1 8777.9 8787.0 8818.2 8854.9 8859.5 8699.5 8738.3 8757.0 8764.6 8783.9 8620.9 8771.2 8794.8 8815.7 8838.3 41247.0 41589.0 41760.8 41764.4 41799.6 3310.3 3380.9 3441.9 3668.2 3939.3 27756.9 27772.6 27938.9 28050.7 28258.3 3888.4 3925.8 3968.8 4047.0 4077.2 278855.0 280307.0 280834.6 281982.0 282347.0 56740.8 57440.4 57570.1 57994.0 58040.1 58352.4 66860.3 68116.3 68980.7 69206.7 16034.7 16125.2 16217.6 16239.0 16280.5 11189.1 11243.6 11251.5 11252.7 11273.8 20112.4 20325.7 20329.6 20512.6 20548.0 7906.0 8229.3 8252.6 8266.1 8277.7 942.4 971.2 1019.6 1019.8 1078.2 28952.7 29015.3 29103.0 29172.3 29359.0 1064.2 1096.6 1101.3 1149.8 1191.5 14802.6 14816.6 15062.2 15168.2 15398.4 313540.0 316367.0 317883.0 318085.0 318190.0 52692.0 53727.7 53751.0 54162.0 54335.0 1368.4 1370.4 1391.3 1392.8 1394.9 27439.0 28143.4 28760.6 29090.6 29311.9 47067.8 47363.8 47438.0 47610.0 47803.3 243569.0 248207.0 248222.0 248681.0 250035.0 32463.2 32776.2 32926.8 33043.2 33316.5 44061.1 44473.1 45084.0 45191.8 45374.3 37295.3 37721.6 38325.6 38497.3 38922.8 37220.6 37268.6 37531.6 37855.2 38223.2 36728.3 37231.6 37915.6 39322.8 39399.2 22969.8 23110.8 23173.5 23675.6 23772.6 24108.2 24111.2 24257.5 25078.6 25078.7 15:50:47 INFO - PROCESS | 14653 | 15:50:47 INFO - PROCESS | 14653 | [#2] jquery.html Cycles:180 Average:25298.09 Median:17807.78 stddev:71327.63 (400.5%) stddev-sans-first:71503.11 15:50:47 INFO - PROCESS | 14653 | Values: 345.0 352.4 353.6 365.8 366.4 16475.8 16893.2 17257.7 17269.1 17300.7 16015.4 16290.3 16394.1 16710.9 16741.2 5208.6 5222.2 5387.7 5388.0 5397.2 5283.6 5326.0 5330.1 5342.8 5370.0 5110.5 5284.8 5311.3 5314.6 5337.6 5278.0 5284.9 5292.4 5310.7 5316.1 4580.0 4705.2 4757.6 4783.7 4793.1 20676.7 20696.6 20702.9 20766.8 20990.0 2299.8 2356.0 2907.3 2948.1 2971.9 13013.6 13350.3 13508.9 13580.5 13698.7 1825.6 1858.4 1884.6 1886.7 1901.0 56959.4 59709.4 60005.4 62186.7 62955.7 9485.0 9664.4 9872.1 9883.7 9965.6 12791.4 12840.2 12879.0 12881.9 12913.7 7462.6 7560.5 7633.9 7722.3 7736.1 7579.1 7608.5 7721.9 7742.5 7896.4 4283.2 4329.9 4334.0 4364.6 4383.5 1814.4 1817.6 1853.4 1865.4 1895.6 899.7 956.9 1015.7 1016.3 1018.1 16754.8 17207.3 17354.7 17466.1 17675.3 975.2 978.9 1008.7 1017.1 1027.6 9705.6 9931.4 9980.5 10030.1 10084.4 430119.0 433713.0 435613.0 436612.0 439807.0 74522.0 76527.2 76721.2 76749.2 77444.6 1004.3 1004.5 1018.9 1030.4 1040.8 14528.0 15212.4 15293.8 15473.1 15571.9 34285.3 34748.1 35263.1 35367.0 35498.5 43111.4 44119.6 44874.3 45323.3 45520.5 7800.7 7894.6 7910.3 7926.6 8163.5 8773.0 11736.2 12033.5 12155.4 12536.1 10812.3 11025.3 11066.8 11072.5 11118.2 10917.0 11073.4 11248.2 11319.3 11475.5 10725.7 10736.6 10940.2 11170.9 11291.8 7382.4 7609.9 7734.5 7856.1 8066.4 10308.9 10563.6 10731.5 10846.3 11138.7 15:50:47 INFO - PROCESS | 14653 | 15:50:47 INFO - PROCESS | 14653 | [#3] mootools.html Cycles:180 Average:5576.54 Median:6659.52 stddev:2936.77 (44.1%) stddev-sans-first:2929.07 15:50:47 INFO - PROCESS | 14653 | Values: 1505.1 1523.1 1720.6 1829.6 1859.0 7812.2 7917.2 8005.6 8021.6 8035.9 8079.2 8112.0 8184.0 8208.4 8213.7 2255.5 2276.2 2293.8 2294.4 2296.6 2320.8 2328.3 2369.8 2370.1 2378.8 2291.9 2316.0 2341.7 2388.6 2392.7 2336.6 2347.0 2356.9 2358.6 2372.8 2352.0 2374.3 2375.8 2375.8 2387.1 8123.8 8139.3 8141.2 8145.0 8177.9 4673.1 4695.1 4793.3 4979.3 4985.0 3129.5 3142.5 3186.0 3191.1 3230.1 949.3 958.6 961.4 972.0 998.6 10897.3 11088.3 11120.2 11146.9 11205.4 4205.5 4260.1 4278.1 4303.8 4378.4 8719.2 8726.1 8727.5 8739.2 8782.3 4800.0 4822.8 4854.7 4871.4 4880.3 4421.1 4480.1 4521.5 4565.0 4582.8 3494.7 3537.5 3546.3 3553.4 3566.3 1016.5 1031.7 1037.9 1042.3 1109.9 1355.1 1357.3 1359.3 1378.2 1383.8 7498.7 7652.9 7678.8 7699.6 7700.6 469.0 476.8 477.7 481.1 483.3 5789.1 5837.3 5853.1 5892.5 5895.8 9427.3 9932.5 9947.0 10034.4 10104.6 9769.2 9837.5 9881.7 9882.2 9925.5 7499.6 7598.5 7613.5 7629.0 7723.7 7235.4 7329.3 7377.3 7400.7 7402.3 8186.8 8852.3 8859.7 9067.4 9092.8 8529.3 8674.0 8689.5 8798.5 8942.7 6190.6 6679.6 6829.9 7038.9 7116.0 7439.5 7521.5 7547.5 7557.5 7613.2 6655.9 6869.9 6915.4 7018.1 7028.9 6663.1 6685.8 6802.8 6831.6 6896.1 7027.2 7033.3 7044.0 7097.4 7315.5 6617.3 6670.5 6714.2 6726.0 6752.7 6618.5 6668.6 6702.4 6722.6 6735.4 15:50:47 INFO - PROCESS | 14653 | 15:50:47 INFO - PROCESS | 14653 | [#4] prototype.html Cycles:180 Average:5554.18 Median:6381.96 stddev:1746.57 (27.4%) stddev-sans-first:1706.46 15:50:47 INFO - PROCESS | 14653 | Values: 305.2 313.1 323.1 327.9 328.9 6272.6 6282.2 6352.4 6375.3 6394.1 6211.4 6214.1 6223.3 6250.8 6280.0 4591.3 4714.5 4724.5 4734.8 4736.8 4675.6 4702.1 4705.1 4705.9 4716.2 4664.4 4667.6 4672.0 4672.9 4674.1 4653.6 4669.2 4672.3 4677.3 4696.5 4007.4 4008.6 4010.4 4017.0 4025.6 5868.6 5959.8 6018.8 6024.1 6024.6 5384.8 5403.4 5417.3 5432.0 5437.6 6601.7 6605.8 6610.5 6622.5 6630.8 4380.3 4401.4 4403.0 4407.1 4414.8 6872.2 6924.8 6952.8 6958.9 6967.0 4367.1 4528.5 4529.9 4532.1 4533.2 4494.5 4496.3 4500.5 4503.4 4506.3 5304.8 5326.9 5334.0 5363.3 5364.5 6670.3 6699.3 6711.9 6715.5 6726.5 1576.7 1624.2 1624.9 1626.7 1627.2 1022.1 1025.2 1051.3 1067.4 1072.7 6388.6 6406.4 6419.7 6422.8 6430.8 6867.2 6893.3 6935.1 6936.4 6943.7 6275.2 6364.1 6429.8 6467.0 6488.9 3710.1 3724.8 3743.3 3743.5 3747.5 7201.4 7264.0 7352.4 7385.9 7402.2 7163.1 7187.1 7194.6 7201.1 7201.2 7183.0 7387.0 7408.3 7460.1 7461.6 6985.1 7009.8 7010.9 7028.8 7030.5 6832.4 6871.1 6925.3 6925.9 6935.4 7375.7 7391.6 7396.8 7397.4 7401.1 4529.3 4642.1 4650.2 4667.7 4675.0 6760.3 6783.4 6874.8 6884.2 6886.4 6626.5 6668.1 6675.1 6680.7 6688.2 6645.2 6666.9 6676.9 6695.1 6696.6 6405.8 6541.3 6572.3 6574.6 6589.6 6679.0 6720.7 6725.2 6728.1 6734.6 6501.4 6514.5 6519.5 6521.1 6540.1 15:50:47 INFO - PROCESS | 14653 | 15:50:47 INFO - PROCESS | 14653 | [#5] yui.html Cycles:180 Average:13691.14 Median:47958.88 stddev:15515.90 (32.4%) stddev-sans-first:15529.17 15:50:47 INFO - PROCESS | 14653 | Values: 786.8 803.3 809.8 832.6 854.8 13761.7 13898.6 13898.9 13936.3 13958.2 12736.4 12755.7 12771.8 13395.2 13453.7 699.7 848.4 861.0 864.6 865.0 848.4 864.4 867.1 869.7 869.7 885.3 889.3 893.6 900.7 904.4 886.0 890.8 895.4 896.5 897.9 655.2 655.2 656.1 656.5 657.2 13167.1 13353.1 13381.7 13388.6 13520.1 13291.8 13535.9 13592.3 13615.2 13784.2 10085.5 10321.1 10397.0 10701.7 10737.1 3604.5 3639.2 3662.5 3668.9 3690.8 49804.5 49897.3 50278.2 50562.5 50588.0 9570.0 9760.0 9855.5 9895.0 10075.3 19546.4 19584.4 19597.0 19610.0 19716.6 7427.3 7525.4 7591.0 7750.1 7833.8 4243.3 4280.6 4328.4 4333.2 4336.8 3196.4 3206.9 3225.9 3226.5 3244.7 557.1 567.6 574.9 577.3 583.1 530.7 563.2 619.4 622.0 629.0 8398.5 8455.7 8493.4 8586.2 8619.8 568.8 637.3 640.5 641.6 657.0 3632.7 3883.7 3895.9 3910.3 3942.3 54277.0 54914.5 55067.0 55387.4 55455.2 49338.0 49399.8 49693.0 50946.5 51257.5 43116.6 43240.4 43700.1 44503.8 46579.8 8108.3 8144.4 8203.0 8251.9 8258.0 33028.7 33407.2 34040.8 34500.3 34941.8 38853.8 39014.0 42692.6 43556.3 43829.8 11103.8 11226.7 11569.7 11752.3 12008.5 12369.8 12613.6 12621.7 12699.3 13384.1 11061.2 11878.2 11925.8 12239.9 12253.7 11595.9 11852.8 12218.1 12489.2 12496.3 10435.9 11148.7 11314.4 11738.6 11947.2 9083.0 9108.2 9173.7 9313.4 9922.9 8436.8 8490.6 8719.9 9323.7 9831.2 15:50:47 INFO - PROCESS | 14653 | -------- Summary: end -------- 15:50:47 INFO - PROCESS | 14653 | 15:50:47 INFO - PROCESS | 14653 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:47 INFO - PROCESS | 14653 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:47 INFO - PROCESS | 14653 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:47 INFO - PROCESS | 14653 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:47 INFO - PROCESS | 14653 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:47 INFO - PROCESS | 14653 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:47 INFO - PROCESS | 14653 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:47 INFO - PROCESS | 14653 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:47 INFO - TEST-INFO | 14653: exit 0 15:50:47 INFO - TEST-OK | dromaeo_css | took 1109220ms 15:50:47 INFO - TEST-START | kraken 15:50:47 INFO - operating with platform_type : linux_ 15:50:47 INFO - Initialising browser for kraken test... 15:50:47 INFO - TEST-INFO | started process 14889 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfsyu5L/profile http://localhost:35989/getInfo.html) 15:50:50 INFO - PROCESS | 14889 | 15:50:50 INFO - PROCESS | 14889 | (process:14961): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:50:51 INFO - PROCESS | 14889 | __metrics Screen width/height:1600/1200 15:50:51 INFO - PROCESS | 14889 | colorDepth:24 15:50:51 INFO - PROCESS | 14889 | Browser inner width/height: 1024/697 15:50:51 INFO - PROCESS | 14889 | __metrics 15:50:52 ERROR - PROCESS | 14889 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:50:52 INFO - PROCESS | 14889 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:52 INFO - PROCESS | 14889 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:52 INFO - PROCESS | 14889 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:52 INFO - PROCESS | 14889 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:52 INFO - PROCESS | 14889 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:52 INFO - PROCESS | 14889 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:52 INFO - PROCESS | 14889 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:52 INFO - PROCESS | 14889 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:52 INFO - PROCESS | 14889 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:50:52 INFO - TEST-INFO | 14889: exit 0 15:50:52 INFO - Browser initialized. 15:50:52 INFO - Running cycle 1/1 for kraken test... 15:50:52 INFO - TEST-INFO | started process 15012 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfsyu5L/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:54 INFO - PROCESS | 15012 | 15:50:54 INFO - PROCESS | 15012 | (process:15069): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:51:04 INFO - PROCESS | 15012 | RSS: Main: 160702464 15:51:04 INFO - PROCESS | 15012 | 15:51:07 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35989/tests/kraken/driver.html?testName=audio-beat-detection) 15:51:07 INFO - PROCESS | 15012 | RSS: Main: 167505920 15:51:07 INFO - PROCESS | 15012 | 15:51:10 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35989/tests/kraken/driver.html?testName=audio-dft) 15:51:11 INFO - PROCESS | 15012 | RSS: Main: 169799680 15:51:11 INFO - PROCESS | 15012 | 15:51:13 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35989/tests/kraken/driver.html?testName=audio-fft) 15:51:14 INFO - PROCESS | 15012 | RSS: Main: 163229696 15:51:14 INFO - PROCESS | 15012 | 15:51:16 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35989/tests/kraken/driver.html?testName=audio-oscillator) 15:51:17 INFO - PROCESS | 15012 | RSS: Main: 164614144 15:51:17 INFO - PROCESS | 15012 | 15:51:19 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35989/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:51:20 INFO - PROCESS | 15012 | RSS: Main: 163123200 15:51:20 INFO - PROCESS | 15012 | 15:51:23 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35989/tests/kraken/driver.html?testName=imaging-darkroom) 15:51:23 INFO - PROCESS | 15012 | RSS: Main: 164265984 15:51:23 INFO - PROCESS | 15012 | 15:51:27 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35989/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:27 INFO - PROCESS | 15012 | RSS: Main: 164835328 15:51:27 INFO - PROCESS | 15012 | 15:51:30 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35989/tests/kraken/driver.html?testName=json-parse-financial) 15:51:31 INFO - PROCESS | 15012 | RSS: Main: 166912000 15:51:31 INFO - PROCESS | 15012 | 15:51:32 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35989/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:33 INFO - PROCESS | 15012 | RSS: Main: 166203392 15:51:33 INFO - PROCESS | 15012 | 15:51:35 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35989/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:35 INFO - PROCESS | 15012 | RSS: Main: 166125568 15:51:35 INFO - PROCESS | 15012 | 15:51:37 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35989/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:51:38 INFO - PROCESS | 15012 | RSS: Main: 168108032 15:51:38 INFO - PROCESS | 15012 | 15:51:40 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:51:41 INFO - PROCESS | 15012 | RSS: Main: 168083456 15:51:41 INFO - PROCESS | 15012 | 15:51:44 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:44 INFO - PROCESS | 15012 | RSS: Main: 167874560 15:51:44 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | Cycle 1(1): loaded http://localhost:35989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35989/tests/kraken/driver.html?testName=ai-astar) 15:51:46 INFO - PROCESS | 15012 | RSS: Main: 167510016 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | __start_tp_report 15:51:46 INFO - PROCESS | 15012 | _x_x_mozilla_page_load 15:51:46 INFO - PROCESS | 15012 | _x_x_mozilla_page_load_details 15:51:46 INFO - PROCESS | 15012 | |i|pagename|runs| 15:51:46 INFO - PROCESS | 15012 | |0;ai-astar;112;107;113;113;113;123;110;110;110;111 15:51:46 INFO - PROCESS | 15012 | |1;audio-beat-detection;149;127;151;174;128;152;153;127;174;127 15:51:46 INFO - PROCESS | 15012 | |2;audio-dft;162;163;163;163;167;164;166;167;167;162 15:51:46 INFO - PROCESS | 15012 | |3;audio-fft;76;74;76;77;75;76;75;161;77;75 15:51:46 INFO - PROCESS | 15012 | |4;audio-oscillator;93;95;134;94;93;94;139;94;92;146 15:51:46 INFO - PROCESS | 15012 | |5;imaging-gaussian-blur;121;118;117;117;117;117;118;119;118;118 15:51:46 INFO - PROCESS | 15012 | |6;imaging-darkroom;147;147;148;146;147;145;146;146;148;146 15:51:46 INFO - PROCESS | 15012 | |7;imaging-desaturate;97;97;96;97;98;96;97;97;96;97 15:51:46 INFO - PROCESS | 15012 | |8;json-parse-financial;58;59;60;57;58;58;58;57;62;55 15:51:46 INFO - PROCESS | 15012 | |9;json-stringify-tinderbox;68;68;67;68;68;69;68;68;68;69 15:51:46 INFO - PROCESS | 15012 | |10;stanford-crypto-aes;83;85;86;85;84;83;83;83;85;82 15:51:46 INFO - PROCESS | 15012 | |11;stanford-crypto-ccm;117;120;119;124;128;129;120;120;123;125 15:51:46 INFO - PROCESS | 15012 | |12;stanford-crypto-pbkdf2;142;153;159;149;142;153;151;161;153;140 15:51:46 INFO - PROCESS | 15012 | |13;stanford-crypto-sha256-iterative;70;69;70;72;69;69;71;71;68;68 15:51:46 INFO - PROCESS | 15012 | __end_tp_report 15:51:46 INFO - PROCESS | 15012 | __start_cc_report 15:51:46 INFO - PROCESS | 15012 | _x_x_mozilla_cycle_collect,806 15:51:46 INFO - PROCESS | 15012 | __end_cc_report 15:51:46 INFO - PROCESS | 15012 | __startTimestamp1456876306570__endTimestamp 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | ------- Summary: start ------- 15:51:46 INFO - PROCESS | 15012 | Number of tests: 14 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.50 stddev:4.24 (3.8%) stddev-sans-first:4.49 15:51:46 INFO - PROCESS | 15012 | Values: 112.0 107.0 113.0 113.0 113.0 123.0 110.0 110.0 110.0 111.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:151.50 stddev:18.54 (12.2%) stddev-sans-first:19.64 15:51:46 INFO - PROCESS | 15012 | Values: 149.0 127.0 151.0 174.0 128.0 152.0 153.0 127.0 174.0 127.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.12 (1.3%) stddev-sans-first:2.06 15:51:46 INFO - PROCESS | 15012 | Values: 162.0 163.0 163.0 163.0 167.0 164.0 166.0 167.0 167.0 162.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:27.00 (35.5%) stddev-sans-first:28.48 15:51:46 INFO - PROCESS | 15012 | Values: 76.0 74.0 76.0 77.0 75.0 76.0 75.0 161.0 77.0 75.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:93.50 stddev:22.46 (24.0%) stddev-sans-first:23.21 15:51:46 INFO - PROCESS | 15012 | Values: 93.0 95.0 134.0 94.0 93.0 94.0 139.0 94.0 92.0 146.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:0.71 15:51:46 INFO - PROCESS | 15012 | Values: 121.0 118.0 117.0 117.0 117.0 117.0 118.0 119.0 118.0 118.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 15:51:46 INFO - PROCESS | 15012 | Values: 147.0 147.0 148.0 146.0 147.0 145.0 146.0 146.0 148.0 146.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 15:51:46 INFO - PROCESS | 15012 | Values: 97.0 97.0 96.0 97.0 98.0 96.0 97.0 97.0 96.0 97.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:1.87 (3.2%) stddev-sans-first:1.99 15:51:46 INFO - PROCESS | 15012 | Values: 58.0 59.0 60.0 57.0 58.0 58.0 58.0 57.0 62.0 55.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 15:51:46 INFO - PROCESS | 15012 | Values: 68.0 68.0 67.0 68.0 68.0 69.0 68.0 68.0 68.0 69.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.50 stddev:1.29 (1.5%) stddev-sans-first:1.32 15:51:46 INFO - PROCESS | 15012 | Values: 83.0 85.0 86.0 85.0 84.0 83.0 83.0 83.0 85.0 82.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:123.50 stddev:3.98 (3.2%) stddev-sans-first:3.69 15:51:46 INFO - PROCESS | 15012 | Values: 117.0 120.0 119.0 124.0 128.0 129.0 120.0 120.0 123.0 125.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:153.00 stddev:7.13 (4.7%) stddev-sans-first:6.91 15:51:46 INFO - PROCESS | 15012 | Values: 142.0 153.0 159.0 149.0 142.0 153.0 151.0 161.0 153.0 140.0 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 15:51:46 INFO - PROCESS | 15012 | Values: 70.0 69.0 70.0 72.0 69.0 69.0 71.0 71.0 68.0 68.0 15:51:46 INFO - PROCESS | 15012 | -------- Summary: end -------- 15:51:46 INFO - PROCESS | 15012 | 15:51:46 INFO - PROCESS | 15012 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:51:46 INFO - PROCESS | 15012 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:51:46 INFO - PROCESS | 15012 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:51:46 INFO - PROCESS | 15012 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:51:46 INFO - PROCESS | 15012 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:51:47 INFO - TEST-INFO | 15012: exit 0 15:51:47 INFO - TEST-OK | kraken | took 59934ms 15:51:47 INFO - SUITE-END | took 1169s 15:51:47 INFO - Completed test suite (00:19:29) 15:51:47 INFO - Working with test: dromaeo_css 15:51:47 INFO - Generating results file: dromaeo_css 15:51:47 INFO - Working with test: kraken 15:51:47 INFO - Generating results file: kraken 15:51:47 INFO - javascript benchmark 15:51:47 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:51:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 15:51:47 INFO - process_Request line: dromaeo_css 6998.05 graph.html#tests=[[72,64,43]] 15:51:47 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:51:47 INFO - process_Request line: kraken 1528.50 graph.html#tests=[[232,64,43]] 15:51:47 INFO - RETURN: dromaeo_css: 6998.05 15:51:47 INFO - RETURN: kraken: 1528.50 15:51:47 INFO - javascript benchmark 15:51:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3220.5813244278247, 3221.4040402525534, 3246.155999440145, 3268.7548433867464, 3277.1970867137557, 5211.8697032574155, 5232.921506177406, 5272.182811664188, 5282.102042652748, 5300.416954135042, 5323.866903327419, 5384.730763461831, 5390.6226564140525, 5448.891022179554, 5449.782008719656, 4923.212286034244, 4939.851804445872, 4997.250412438145, 5026.597872170236, 5095.108356037697, 240.47110882658595, 4943.8516844494725, 4977.875553111165, 4984.950150498485, 5010.448850626446, 4953.752312384402, 4964.329815474919, 4983.252512123192, 5011.273365362039, 5041.395032596075, 4885.804567817283, 4954.975225123887, 4961.0, 5017.147084995559, 5063.974680126613, 4883.902321953541, 4916.385451818523, 4937.901241975141, 4951.183054795954, 4985.651004429691, 5153.201253805666, 5230.712310822903, 5247.737613119329, 5275.28783614211, 5281.102212623863, 5668.064769313059, 5775.740091695884, 5803.9709801451145, 5826.213461182729, 5848.88302233953, 5831.854203644943, 5857.033589457735, 5857.297124345063, 5862.589618726691, 5902.2032025676845, 5382.192671099367, 5441.347038355383, 5460.290162278918, 5461.044317244467, 5470.206820011116, 5850.444207800252, 5918.940810591839, 5927.525797936155, 5940.762369505258, 5941.792037278675, 5770.653760774367, 5773.653580785166, 5782.479576838105, 5783.624064435799, 5783.652980821164, 5819.767209311664, 5835.212246346774, 5855.619384739978, 5861.003629383015, 5871.148683440877, 5611.8597035073635, 5760.94239057604, 5807.303123625192, 5809.2738407699035, 5862.208601838783, 5688.658680479184, 5765.827025189167, 5797.884042319214, 5800.970995145081, 5881.323647780475, 4380.518143004267, 4385.122975404868, 4402.141582391403, 4406.9643633746045, 4449.866504004885, 3940.4877365942816, 3943.526776786804, 3945.191235796655, 3954.9011274717786, 4007.8797636070963, 5339.839804805862, 5391.649542779707, 5415.945840541623, 5427.050266203399, 5457.508824205841, 5706.28671416073, 5706.315242170883, 5732.914006289909, 5733.025385684444, 5740.712964351766, 5379.67721936685, 5428.6199966002005, 5457.181422786613, 5491.2312276281355, 5519.862003449865, 4916.311716359713, 4928.556429921325, 4958.950410495849, 4962.454130045692, 4987.476314986947, 6056.364081771439, 6068.4538391544975, 6072.089186622042, 6075.878482430327, 6081.604695694766, 5668.206451096849, 5779.2198053263955, 5805.651660900359, 5828.397190772572, 5835.883282334415, 5996.0, 6019.939800601938, 6032.909506357496, 6034.39656034393, 6063.484603808725, 5589.692566908859, 5717.885642287048, 5733.254676891977, 5738.598298119092, 5755.568332375173, 5750.798722044876, 5784.942150578609, 5785.681787501728, 5797.797077102281, 5837.824865254049, 5639.154126881001, 5647.124695672177, 5649.830505084854, 5653.886922261614, 5693.0, 5597.272354593877, 5607.214989901336, 5643.492085712305, 5645.774169033192, 5647.745851436613, 5427.0, 5452.345718513804, 5517.282753242052, 5572.192032155396, 5614.522765564972, 5587.078132108157, 5602.607817452739, 5612.579056570692, 5632.5212356950115, 5642.548596112383, 5438.564914806885, 5457.072297709319, 5462.617616766788, 5463.235147079333, 5492.340919089735], "unit": "score", "name": "dojo.html", "value": 5302.2002577606445}, {"lowerIsBetter": false, "replicates": [502.13381916194567, 528.4002656984321, 548.9423610520895, 556.8273835111113, 557.8382269141948, 36482.81758591207, 36854.63145368549, 37029.0, 37102.8144859276, 37108.628913710854, 39622.405663915066, 40269.59730402695, 40272.395914061315, 40300.59699403005, 40331.19337613246, 8421.368397370206, 8606.354523410739, 8626.482411055325, 8639.784005399852, 8677.609507572175, 8380.455270407405, 8553.358498112635, 8574.69988550401, 8574.871376929352, 8590.055093939693, 8777.912220877804, 8786.956065219696, 8818.20636142747, 8854.86717699235, 8859.512726800023, 8699.478031318142, 8738.30093592511, 8756.956215218883, 8764.649414023432, 8783.868241976375, 8620.870686939701, 8771.16673915977, 8794.824103517894, 8815.691450799255, 8838.337124715672, 41247.0, 41589.0, 41760.79119604383, 41764.37353439701, 41799.58200418018, 3310.2551925816497, 3380.9323813523592, 3441.9311613767836, 3668.248009158116, 3939.330313846653, 27756.861215693792, 27772.58341124885, 27938.860305698545, 28050.719492805016, 28258.29354266139, 3888.3972984187494, 3925.7840818754958, 3968.761874287523, 4047.0489434982755, 4077.2049450357194, 278855.0, 280307.0, 280834.5958270216, 281982.0, 282347.0, 56740.758516563146, 57440.425595744346, 57570.136447953315, 57994.0, 58040.12939805906, 58352.416475834696, 66860.3313966854, 68116.318836811, 68980.6550967252, 69206.65396672985, 16034.679306413806, 16125.193740312938, 16217.59456013609, 16239.0, 16280.511584652479, 11189.104871610252, 11243.60647377338, 11251.493682784294, 11252.718682033015, 11273.830892536618, 20112.39662810118, 20325.695114573293, 20329.593408131754, 20512.58974820525, 20548.0, 7906.0, 8229.341652667772, 8252.628631711588, 8266.13205613402, 8277.668893244203, 942.3780304998668, 971.1987610221596, 1019.612547232062, 1019.8368261078192, 1078.2236789511696, 28952.710472895422, 29015.274618134714, 29103.0, 29172.27069323284, 29359.0, 1064.2177999170603, 1096.6381094238882, 1101.300674071954, 1149.804533229353, 1191.4638412714314, 14802.62993425173, 14816.555503334917, 15062.246887655574, 15168.165750883587, 15398.384064637288, 313540.0, 316367.0, 317883.0, 318085.0, 318190.0, 52692.0, 53727.73136134294, 53751.0, 54162.0, 54335.0, 1368.4047439363908, 1370.4240123857444, 1391.3391139208795, 1392.7980442835935, 1394.8744612984676, 27439.0, 28143.43713125767, 28760.568591470725, 29090.563641545818, 29311.85344073266, 47067.76466117647, 47363.763181185255, 47438.0, 47610.04779904313, 47803.28295075507, 243569.0, 248207.0, 248222.0, 248681.0, 250035.0, 32463.18842028968, 32776.18059548435, 32926.83536582302, 33043.173920652174, 33316.500252495745, 44061.118777623626, 44473.11053778971, 45084.0, 45191.77404112958, 45374.31938520991, 37295.25409491849, 37721.62278377181, 38325.61674383332, 38497.30518863653, 38922.80538597289, 37220.6277937228, 37268.627313726516, 37531.62468375391, 37855.242895142495, 38223.23553528969, 36728.26543469169, 37231.627683722814, 37915.62084379231, 39322.80338598289, 39399.212015760095, 22969.77030229676, 23110.76889231086, 23173.53652926966, 23675.64486532669, 23772.643410349203, 24108.1918856083, 24111.15610953608, 24257.514849702555, 25078.62382064307, 25078.74921250837], "unit": "score", "name": "ext.html", "value": 18460.241895578634}, {"lowerIsBetter": false, "replicates": [344.97499676896615, 352.4448992836282, 353.6021975277812, 365.78053168099143, 366.41190888623777, 16475.846690731654, 16893.155342232887, 17257.654846903053, 17269.136543172823, 17300.74048889266, 16015.439459618916, 16290.348386064572, 16394.09832459214, 16710.916445417788, 16741.246643901024, 5208.609354298424, 5222.16445368742, 5387.730613469331, 5388.0, 5397.190421436777, 5283.6037297202865, 5326.041312563756, 5330.093884039703, 5342.839714808562, 5370.0333939891, 5110.463401342861, 5284.762185701653, 5311.282976798141, 5314.574834013289, 5337.599680023995, 5278.0, 5284.867878303035, 5292.444293349181, 5310.734463276821, 5316.069687804618, 4580.0, 4705.223638099709, 4757.5718185363485, 4783.736894470802, 4793.089313030548, 20676.689849652266, 20696.58606827855, 20702.896485517627, 20766.79233207664, 20989.950502474814, 2299.8275129365366, 2355.9646605300936, 2907.3270817667085, 2948.1155653304136, 2971.895983640584, 13013.609591712264, 13350.26573538455, 13508.93245533776, 13580.524681636096, 13698.726025479535, 1825.607494388713, 1858.4053103007043, 1884.6042331110484, 1886.7452893859427, 1900.9524761880925, 56959.43040569583, 59709.40290597082, 60005.39994600042, 62186.689066554376, 62955.6852215736, 9485.0, 9664.420134791935, 9872.062154095349, 9883.654072107585, 9965.601375944882, 12791.360431978364, 12840.165389249669, 12879.0, 12881.871181288067, 12913.677158070936, 7462.552246865205, 7560.546367217985, 7633.931249625057, 7722.3049925506975, 7736.149023607399, 7579.1284002339335, 7608.505447145918, 7721.884171737428, 7742.535447873033, 7896.447248692536, 4283.186194623012, 4329.935050974238, 4333.956660433419, 4364.563543645673, 4383.539728328544, 1814.410316647095, 1817.554699098703, 1853.3698542495347, 1865.4496923407628, 1895.639828432621, 899.6761165980242, 956.9473678947586, 1015.7141646772684, 1016.3444578246989, 1018.063381688848, 16754.832451675327, 17207.311707531808, 17354.739678904825, 17466.12669366552, 17675.292988280326, 975.2100798353357, 978.8874279457812, 1008.6973907827622, 1017.1100287248657, 1027.6403258859489, 9705.64202722369, 9931.404115753077, 9980.45107519079, 10030.097291243823, 10084.445355505371, 430119.0, 433713.0, 435613.0, 436612.0, 439807.0, 74522.0, 76527.23472765312, 76721.23278767141, 76749.23250767421, 77444.61277693576, 1004.2869562610482, 1004.4626125023224, 1018.923580731448, 1030.3508789462592, 1040.7658276887792, 14528.0, 15212.391504339703, 15293.847061529686, 15473.148976806384, 15571.922140389226, 34285.31429371348, 34748.13129671779, 35263.11842203965, 35367.0, 35498.46752298666, 43111.35332970071, 44119.55880441154, 44874.326885096096, 45323.32015019711, 45520.54479455163, 7800.687972481264, 7894.644740986554, 7910.327622151951, 7926.643301051582, 8163.469374490639, 8772.991106022633, 11736.237144585575, 12033.4584943676, 12155.392230388623, 12536.122471426912, 10812.297200681931, 11025.283356581796, 11066.778664426505, 11072.501737421997, 11118.166137539878, 10917.0, 11073.390963496762, 11248.212625116163, 11319.320840749582, 11475.48360323804, 10725.678229653124, 10736.624218152327, 10940.179486538382, 11170.944145279222, 11291.814359492135, 7382.4094072473, 7609.885851712118, 7734.497257678233, 7856.096548896721, 8066.435349525477, 10308.896911030793, 10563.577456901945, 10731.463426828783, 10846.349219046882, 11138.665840024812], "unit": "score", "name": "jquery.html", "value": 8478.704435642068}, {"lowerIsBetter": false, "replicates": [1505.1270263247318, 1523.0861483110132, 1720.5526563093592, 1829.6157806860558, 1858.953526161845, 7812.218778122185, 7917.247861453153, 8005.599720013998, 8021.639026243818, 8035.879461808063, 8079.151689072636, 8111.959440202805, 8184.0, 8208.425410221287, 8213.671453141867, 2255.5263394687136, 2276.1578216059997, 2293.827962902789, 2294.380517260347, 2296.5636529059425, 2320.791128798408, 2328.3364241191266, 2369.7985671217966, 2370.0875163062174, 2378.797802186816, 2291.873946932918, 2316.027268547214, 2341.695579574661, 2388.558116748407, 2392.7248366437907, 2336.556054349685, 2346.9530609387803, 2356.8821558922073, 2358.6344116661944, 2372.750861159571, 2352.047420794581, 2374.2877136858874, 2375.750546192642, 2375.845570037959, 2387.1048356866177, 8123.837523249561, 8139.308158806509, 8141.22658347456, 8144.959275203586, 8177.918220817775, 4673.11210869937, 4695.084458530588, 4793.2810078488155, 4979.30289759434, 4984.950150498485, 3129.4992801151707, 3142.450071237547, 3186.0441867439677, 3191.0586377018603, 3230.095573239497, 949.264320151881, 958.5925981457922, 961.3606951377326, 972.042538099971, 998.5756053677159, 10897.291676041112, 11088.279261847954, 11120.165987550967, 11146.944265278622, 11205.439728013649, 4205.453291072141, 4260.062786187096, 4278.122984788111, 4303.784810759512, 4378.365137055109, 8719.171678690514, 8726.127387261224, 8727.476351418934, 8739.169778870997, 8782.341324400695, 4800.0, 4822.831200908022, 4854.660173787872, 4871.391076115486, 4880.341153944172, 4421.071574969228, 4480.059187570647, 4521.4574251089425, 4565.0413413183605, 4582.839600614029, 3494.7029502492064, 3537.5224344713647, 3546.3261980223674, 3553.431450967833, 3566.3045706087582, 1016.506994107857, 1031.7265924530006, 1037.9377237365782, 1042.3485321673954, 1109.8557187565564, 1355.0650051464654, 1357.2738584857054, 1359.34071975092, 1378.1868697468542, 1383.75784237758, 7498.6625601848045, 7652.923470765221, 7678.769636910902, 7699.615019249015, 7700.576468294297, 468.9882752931204, 476.833108412053, 477.7444067423981, 481.11474886209544, 483.3450674336224, 5789.073748200268, 5837.270341207349, 5853.063509838491, 5892.499137573269, 5895.764169433261, 9427.292953028413, 9932.453715045742, 9947.0, 10034.397936123856, 10104.595816167419, 9769.16962058233, 9837.508124593742, 9881.703548893545, 9882.160016398686, 9925.454100024424, 7499.6250187490405, 7598.506097103671, 7613.505122167041, 7629.04636920396, 7723.729669461654, 7235.384992275715, 7329.340359367682, 7377.26227377258, 7400.703971841282, 7402.29678180572, 8186.7953301167945, 8852.336074794288, 8859.689910853089, 9067.410618309788, 9092.818143637223, 8529.270633397253, 8674.0, 8689.478631282143, 8798.516081615317, 8942.68700595476, 6190.566660333733, 6679.599224046573, 6829.931700683128, 7038.859222815618, 7116.039334689957, 7439.479236453396, 7521.548707077593, 7547.471676982558, 7557.508761930457, 7613.162552119373, 6655.900161497679, 6869.862602747817, 6915.377616014583, 7018.052562903943, 7028.894566581607, 6663.13379260693, 6685.796556619855, 6802.795916122524, 6831.59010459374, 6896.137982752156, 7027.191872934473, 7033.331833475811, 7043.964780176271, 7097.432205423657, 7315.48791584584, 6617.338266173344, 6670.499712521678, 6714.227863795726, 6725.966370168314, 6752.69612867432, 6618.503612229006, 6668.599884006975, 6702.36327548882, 6722.630255336004, 6735.4274886635185], "unit": "score", "name": "mootools.html", "value": 4486.084772796424}, {"lowerIsBetter": false, "replicates": [305.15015681327503, 313.1419909448112, 323.07278111819085, 327.9065466342093, 328.93585750778607, 6272.56092073555, 6282.246130464339, 6352.428281454668, 6375.330590288023, 6394.104825324458, 6211.378862113786, 6214.130021796952, 6223.315435302113, 6250.8124756257275, 6279.968600156993, 4591.265397536403, 4714.481407045222, 4724.503927087658, 4734.763261836912, 4736.786844591985, 4675.625949924015, 4702.130105930414, 4705.106029854317, 4705.882352941169, 4716.245400735883, 4664.416947881515, 4667.649926255527, 4672.042231342567, 4672.8598142055625, 4674.135284972274, 4653.627709783209, 4669.229577119771, 4672.299155126724, 4677.298405239208, 4696.506866779007, 4007.358822588401, 4008.599140085997, 4010.418489319062, 4016.9598304016877, 4025.6175663311938, 5868.559858010623, 5959.791407300723, 6018.759249630009, 6024.0662697282, 6024.608400453956, 5384.838454846361, 5403.405625381205, 5417.295751552312, 5432.049391356497, 5437.619366644297, 6601.6699165041555, 6605.801825945229, 6610.471162307004, 6622.53642245043, 6630.834229144261, 4380.34294855771, 4401.405810215644, 4403.0, 4407.096545208225, 4414.84548040817, 6872.175338959307, 6924.826879328007, 6952.791416257521, 6958.8956165657555, 6966.999999999949, 4367.082912588328, 4528.547145285445, 4529.932051019237, 4532.093581283691, 4533.184026875128, 4494.52807455219, 4496.258117410656, 4500.459944806578, 4503.41455610775, 4506.301523263899, 5304.761285742151, 5326.92009619856, 5334.013207556614, 5363.302770639792, 5364.544013758874, 6670.299618540081, 6699.296573859772, 6711.899321510181, 6715.529912906148, 6726.529142960044, 1576.676781259839, 1624.2122570553272, 1624.9268782904799, 1626.7397216445313, 1627.2270671430977, 1022.1107636356269, 1025.2259544044348, 1051.2798732867857, 1067.4022547373495, 1072.7050061233224, 6388.584741991755, 6406.423421892052, 6419.716056788568, 6422.839429014219, 6430.807075787734, 6867.175938887365, 6893.276205998298, 6935.133108361455, 6936.445084393236, 6943.6875340609795, 6275.184226050585, 6364.1408409865, 6429.7749578764515, 6466.967665161644, 6488.902666460007, 3710.128119891823, 3724.832382542792, 3743.344914639927, 3743.5320584926885, 3747.4940882980995, 7201.3518783309755, 7264.0, 7352.448566357544, 7385.889211661829, 7402.185759566443, 7163.140423149255, 7187.137543494814, 7194.568325900463, 7201.063861697946, 7201.243869393743, 7182.96408517954, 7387.0, 7408.259174082548, 7460.0674915635545, 7461.626918653937, 6985.057017302599, 7009.754658586925, 7010.859782804213, 7028.789136325919, 7030.472714546328, 6832.419244364086, 6871.072405225231, 6925.272846351262, 6925.89611155823, 6935.410490108397, 7375.668094935633, 7391.556506609621, 7396.7780966568935, 7397.408207343292, 7401.0748656417945, 4529.252673308867, 4642.071585682945, 4650.232711602548, 4667.719936803803, 4675.0, 6760.290169532128, 6783.423409010289, 6874.828129296808, 6884.208316043719, 6886.380225779704, 6626.469882409299, 6668.066470694203, 6675.098861653614, 6680.665966701743, 6688.230853451915, 6645.169353830771, 6666.866662666623, 6676.89984650221, 6695.0626912231355, 6696.59820410777, 6405.775797847053, 6541.34586541342, 6572.34276572339, 6574.638394888327, 6589.637569933508, 6678.966605166943, 6720.731170753115, 6725.159355080615, 6728.125343705287, 6734.552071304693, 6501.44737697301, 6514.54398192122, 6519.4784417245555, 6521.054447105238, 6540.051692504465], "unit": "score", "name": "prototype.html", "value": 4969.77199817794}, {"lowerIsBetter": false, "replicates": [786.7561056072618, 803.2690251870795, 809.7773112394087, 832.6128350317103, 854.8119413728986, 13761.724765504683, 13898.583042508715, 13898.86101138987, 13936.303184840755, 13958.162510249393, 12736.426860791264, 12755.681107972305, 12771.80842287364, 13395.196288222713, 13453.663658408545, 699.6606645776794, 848.3806821020659, 861.0485413617956, 864.567716141929, 864.9870251946226, 848.406115718996, 864.394923553512, 867.0982178534317, 869.6564856881528, 869.7129947117436, 885.3404213860683, 889.3018980100622, 893.5800173918248, 900.6622516556291, 904.430208968349, 885.9911400885973, 890.8396488632076, 895.4492986813128, 896.4710820615868, 897.8653202019684, 655.1712084213474, 655.2301046270613, 656.0520048529876, 656.5108993799649, 657.1621182991676, 13167.144135631153, 13353.13204641705, 13381.66545836352, 13388.598342049656, 13520.12119212248, 13291.800622990662, 13535.864641353657, 13592.320383980761, 13615.18308901469, 13784.172949623055, 10085.546150423248, 10321.12270457012, 10397.0, 10701.732456688567, 10737.141028717684, 3604.4593311003296, 3639.2357604902736, 3662.505561749156, 3668.853245870162, 3690.7970061646597, 49804.50195497998, 49897.25154122691, 50278.24582631227, 50562.49437505614, 50588.0, 9569.952150239204, 9760.0, 9855.507224638739, 9894.950525247328, 10075.294729368874, 19546.413607591796, 19584.412467625993, 19597.0, 19610.0, 19716.60566788656, 7427.3374866588465, 7525.397968162534, 7590.962045189849, 7750.069991600932, 7833.764987050397, 4243.342281946303, 4280.636145927631, 4328.3723860040745, 4333.198358303724, 4336.76147811867, 3196.3926853897683, 3206.8556914938886, 3225.870965161367, 3226.483762597973, 3244.7241984431116, 557.0891592246705, 567.6026781253057, 574.8591595059154, 577.3331801768963, 583.096200888621, 530.745242283706, 563.1580786723792, 619.3651507205151, 622.0358444411145, 629.0, 8398.454100483448, 8455.66177352899, 8493.362997775192, 8586.203629364049, 8619.827603447897, 568.8094488346368, 637.2607774981, 640.546494072215, 641.5733537197711, 656.9868602627921, 3632.6730594246646, 3883.689304855605, 3895.8831235062994, 3910.276598829226, 3942.250972315251, 54277.0, 54914.45085549093, 55067.0, 55387.446125539034, 55455.168172477446, 49338.0, 49399.75300123476, 49693.0, 50946.49053509492, 51257.48742512527, 43116.56883431188, 43240.35139472911, 43700.125997479874, 44503.77748111239, 46579.76710116496, 8108.310793582612, 8144.429889907649, 8203.0, 8251.917480825356, 8257.95871020665, 33028.66971330256, 33407.164820879676, 34040.82979585086, 34500.30999380049, 34941.825290873385, 38853.805730971166, 39014.0, 42692.57307426886, 43556.34665480084, 43829.780851095544, 11103.833442498531, 11226.719332016764, 11569.710757231136, 11752.294862308288, 12008.459619316976, 12369.752604948031, 12613.558525451564, 12621.74756504883, 12699.301538415475, 13384.063115581816, 11061.170412218955, 11878.168528202943, 11925.82111268349, 12239.877601223874, 12253.677146306049, 11595.942020289845, 11852.76294474123, 12218.083643726579, 12489.18820276679, 12496.312702801433, 10435.895641043493, 11148.665540033811, 11314.434278286217, 11738.647840564456, 11947.223430476992, 9082.954585227031, 9108.200857183974, 9173.724788256362, 9313.39462934907, 9922.851157232502, 8436.789080273042, 8490.61792219364, 8719.866417365702, 9323.72028839136, 9831.213502919607], "unit": "score", "name": "yui.html", "value": 6347.471594769709}], "name": "dromaeo_css", "value": 6998.056384915132}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 113.0, 113.0, 113.0, 123.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [149.0, 127.0, 151.0, 174.0, 128.0, 152.0, 153.0, 127.0, 174.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 163.0, 167.0, 164.0, 166.0, 167.0, 167.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 76.0, 77.0, 75.0, 76.0, 75.0, 161.0, 77.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 134.0, 94.0, 93.0, 94.0, 139.0, 94.0, 92.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [121.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 146.0, 147.0, 145.0, 146.0, 146.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 98.0, 96.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 60.0, 57.0, 58.0, 58.0, 58.0, 57.0, 62.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 85.0, 84.0, 83.0, 83.0, 83.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [117.0, 120.0, 119.0, 124.0, 128.0, 129.0, 120.0, 120.0, 123.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 159.0, 149.0, 142.0, 153.0, 151.0, 161.0, 153.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 72.0, 69.0, 69.0, 71.0, 71.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1528.5}]} 15:51:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1528.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6998.05"}}} 15:51:47 INFO - Return code: 0 15:51:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:51:47 ERROR - # TBPL SUCCESS # 15:51:47 INFO - Running post-action listener: _resource_record_post_action 15:51:47 INFO - Running post-run listener: _resource_record_post_run 15:51:48 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 537817088; Read time: 260; Write time: 376856 15:51:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 240525312; Read time: 104; Write time: 193852 15:51:49 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297291776; Read time: 156; Write time: 183004 15:51:49 INFO - Running post-run listener: _upload_blobber_files 15:51:49 INFO - Blob upload gear active. 15:51:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:51:49 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 15:51:49 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'] 15:51:49 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 15:51:49 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:50 INFO - (blobuploader) - INFO - Done attempting. 15:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:51 INFO - (blobuploader) - INFO - Done attempting. 15:51:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:51 INFO - Return code: 0 15:51:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:51:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d4f40208e4c5631a0447ecef5ea0a386857463b47c63893cb4fb7ec997b9378684c0e18c72d9208376ff423e6ca638dcc5da539e741bf86d56b2bea1695c21a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15d2df68871b61822be5d725a4f7d6e4a8e8f7fdcb974a8a491c47d112bdfd3ebc76fe62967d85d49a1035ccf97d57acb53461c652b1faa881f4c89e8d32be14"} 15:51:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:51:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:51:51 INFO - Contents: 15:51:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d4f40208e4c5631a0447ecef5ea0a386857463b47c63893cb4fb7ec997b9378684c0e18c72d9208376ff423e6ca638dcc5da539e741bf86d56b2bea1695c21a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15d2df68871b61822be5d725a4f7d6e4a8e8f7fdcb974a8a491c47d112bdfd3ebc76fe62967d85d49a1035ccf97d57acb53461c652b1faa881f4c89e8d32be14"} 15:51:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:51:51 INFO - Copying logs to upload dir... 15:51:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 15:51:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.371612 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-01 15:51:51.376995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 15:51:51.380682) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132 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/4d4f40208e4c5631a0447ecef5ea0a386857463b47c63893cb4fb7ec997b9378684c0e18c72d9208376ff423e6ca638dcc5da539e741bf86d56b2bea1695c21a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15d2df68871b61822be5d725a4f7d6e4a8e8f7fdcb974a8a491c47d112bdfd3ebc76fe62967d85d49a1035ccf97d57acb53461c652b1faa881f4c89e8d32be14"} build_url:https://queue.taskcluster.net/v1/task/TfVzs89yTKuFsIGegPEp3A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/TfVzs89yTKuFsIGegPEp3A/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/4d4f40208e4c5631a0447ecef5ea0a386857463b47c63893cb4fb7ec997b9378684c0e18c72d9208376ff423e6ca638dcc5da539e741bf86d56b2bea1695c21a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15d2df68871b61822be5d725a4f7d6e4a8e8f7fdcb974a8a491c47d112bdfd3ebc76fe62967d85d49a1035ccf97d57acb53461c652b1faa881f4c89e8d32be14"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 15:51:51.405047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:51:51.405394) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456874677.817901-391480132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 15:51:51.488079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 15:51:51.488467) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 15:51:51.488755) ========= ========= Total master_lag: 0.30 =========