builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1450458877.75 results: success (0) buildid: 20151218082856 builduid: f8aecad89f2e4a39ab50e49aa4ec941a revision: 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.748212) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.748755) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.749046) ========= bash -c pwd in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006396 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.770577) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.771034) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.797746) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.797994) ========= rm -rf properties in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.848435) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.848711) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.849081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:37.849351) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 09:14:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.9M=0s 2015-12-18 09:14:38 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:38.007139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:38.007452) ========= rm -rf scripts in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021192 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:38.056446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:38.056766) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 09:14:38,432 truncating revision to first 12 chars 2015-12-18 09:14:38,432 Setting DEBUG logging. 2015-12-18 09:14:38,432 attempt 1/10 2015-12-18 09:14:38,433 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2a25cd6b592f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 09:14:38,690 unpacking tar archive at: fx-team-2a25cd6b592f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:38.604912) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:38.605206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:38.614086) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:38.614333) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 09:14:38.614722) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-18 09:14:38.615008) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:14:39 INFO - MultiFileLogger online at 20151218 09:14:39 in /builds/slave/test 09:14:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:14:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:39 INFO - {'append_to_log': False, 09:14:39 INFO - 'base_work_dir': '/builds/slave/test', 09:14:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:14:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:39 INFO - 'branch': 'Fx-Team-Non-PGO', 09:14:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:39 INFO - 'config_files': ('talos/linux_config.py',), 09:14:39 INFO - 'default_actions': ('clobber', 09:14:39 INFO - 'read-buildbot-config', 09:14:39 INFO - 'download-and-extract', 09:14:39 INFO - 'populate-webroot', 09:14:39 INFO - 'create-virtualenv', 09:14:39 INFO - 'install', 09:14:39 INFO - 'run-tests'), 09:14:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:39 INFO - 'download_minidump_stackwalk': True, 09:14:39 INFO - 'download_symbols': 'ondemand', 09:14:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:39 INFO - 'installer_path': 'installer.exe', 09:14:39 INFO - 'log_level': 'info', 09:14:39 INFO - 'log_name': 'talos', 09:14:39 INFO - 'log_to_console': True, 09:14:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:14:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:14:39 INFO - 'opt_config_files': (), 09:14:39 INFO - 'pip_index': False, 09:14:39 INFO - 'sps_profile': False, 09:14:39 INFO - 'sps_profile_interval': 0, 09:14:39 INFO - 'suite': 'dromaeojs', 09:14:39 INFO - 'system_bits': '64', 09:14:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:39 INFO - 'title': 'talos-linux64-ix-036', 09:14:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:39 INFO - 'use_talos_json': True, 09:14:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:39 INFO - 'work_dir': 'build'} 09:14:39 INFO - ##### 09:14:39 INFO - ##### Running clobber step. 09:14:39 INFO - ##### 09:14:39 INFO - Running pre-action listener: _resource_record_pre_action 09:14:39 INFO - Running main action method: clobber 09:14:39 INFO - rmtree: /builds/slave/test/build 09:14:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:40 INFO - Running post-action listener: _resource_record_post_action 09:14:40 INFO - ##### 09:14:40 INFO - ##### Running read-buildbot-config step. 09:14:40 INFO - ##### 09:14:40 INFO - Running pre-action listener: _resource_record_pre_action 09:14:40 INFO - Running main action method: read_buildbot_config 09:14:40 INFO - Using buildbot properties: 09:14:40 INFO - { 09:14:40 INFO - "project": "", 09:14:40 INFO - "product": "firefox", 09:14:40 INFO - "script_repo_revision": "production", 09:14:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:14:40 INFO - "repository": "", 09:14:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:14:40 INFO - "buildid": "20151218082856", 09:14:40 INFO - "pgo_build": "False", 09:14:40 INFO - "basedir": "/builds/slave/test", 09:14:40 INFO - "buildnumber": 2232, 09:14:40 INFO - "slavename": "talos-linux64-ix-036", 09:14:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:14:40 INFO - "platform": "ubuntu64_hw", 09:14:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:14:40 INFO - "branch": "fx-team", 09:14:40 INFO - "repo_path": "integration/fx-team", 09:14:40 INFO - "revision": "2a25cd6b592f4f3b942d3fb8476ce10a0e071d65", 09:14:40 INFO - "stage_platform": "linux64", 09:14:40 INFO - "builduid": "f8aecad89f2e4a39ab50e49aa4ec941a", 09:14:40 INFO - "slavebuilddir": "test" 09:14:40 INFO - } 09:14:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:14:40 INFO - Running post-action listener: _resource_record_post_action 09:14:40 INFO - ##### 09:14:40 INFO - ##### Running download-and-extract step. 09:14:40 INFO - ##### 09:14:40 INFO - Running pre-action listener: _resource_record_pre_action 09:14:40 INFO - Running main action method: download_and_extract 09:14:40 INFO - mkdir: /builds/slave/test/build/tests 09:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:40 INFO - https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/test_packages.json 09:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/test_packages.json 09:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:14:43 INFO - Downloaded 1302 bytes. 09:14:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:14:43 INFO - Using the following test package requirements: 09:14:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:14:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:43 INFO - u'jsshell-linux-x86_64.zip'], 09:14:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:14:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:14:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:14:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:14:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:14:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:14:43 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')]} 09:14:43 INFO - https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:54 INFO - Downloaded 21872118 bytes. 09:14:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:14:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:14:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:14:55 INFO - Return code: 0 09:14:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:14: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')]} 09:14:55 INFO - https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:14:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:14:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:14:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:14:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:56 INFO - Downloaded 21872118 bytes. 09:14:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:14:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:14:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:14:57 INFO - Return code: 0 09:14: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')]} 09:14:57 INFO - https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:14:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:14:58 INFO - Downloaded 11132039 bytes. 09:14:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 09:14:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:14:58 INFO - Return code: 0 09:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:58 INFO - https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:14:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:14:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:14:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:14:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:15:00 INFO - Downloaded 53017600 bytes. 09:15:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:15:00 INFO - mkdir: /builds/slave/test/properties 09:15:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:15:00 INFO - Writing to file /builds/slave/test/properties/build_url 09:15:00 INFO - Contents: 09:15:00 INFO - build_url:https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:15:00 INFO - Running post-action listener: _resource_record_post_action 09:15:00 INFO - Running post-action listener: set_extra_try_arguments 09:15:00 INFO - ##### 09:15:00 INFO - ##### Running populate-webroot step. 09:15:00 INFO - ##### 09:15:00 INFO - Running pre-action listener: _resource_record_pre_action 09:15:00 INFO - Running main action method: populate_webroot 09:15:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:15:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:15:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:15:00 INFO - '--tppagecycles', 09:15:00 INFO - '7'], 09:15:00 INFO - 'tests': ['tsvgm']}}, 09:15:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:15:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:15:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:15:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:15:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:15:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:15:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:00 INFO - 'talos_options': ['--e10s'], 09:15:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:00 INFO - 'tests': ['damp', 'tps']}, 09:15:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:00 INFO - 'talos_options': ['--e10s'], 09:15:00 INFO - 'tests': ['damp', 'tps']}, 09:15:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:15:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:15:00 INFO - 'other': {'tests': ['a11yr', 09:15:00 INFO - 'ts_paint', 09:15:00 INFO - 'tpaint', 09:15:00 INFO - 'sessionrestore', 09:15:00 INFO - 'sessionrestore_no_auto_restore']}, 09:15:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:15:00 INFO - 'tests': ['a11yr', 09:15:00 INFO - 'ts_paint', 09:15:00 INFO - 'tpaint', 09:15:00 INFO - 'sessionrestore', 09:15:00 INFO - 'sessionrestore_no_auto_restore']}, 09:15:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:15:00 INFO - 'tests': ['a11yr', 09:15:00 INFO - 'ts_paint', 09:15:00 INFO - 'tpaint', 09:15:00 INFO - 'sessionrestore', 09:15:00 INFO - 'sessionrestore_no_auto_restore']}, 09:15:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:15:00 INFO - 'tests': ['a11yr', 09:15:00 INFO - 'ts_paint', 09:15:00 INFO - 'tpaint', 09:15:00 INFO - 'sessionrestore', 09:15:00 INFO - 'sessionrestore_no_auto_restore']}, 09:15:00 INFO - 'other_l64': {'tests': ['a11yr', 09:15:00 INFO - 'ts_paint', 09:15:00 INFO - 'tpaint', 09:15:00 INFO - 'sessionrestore', 09:15:00 INFO - 'sessionrestore_no_auto_restore']}, 09:15:00 INFO - 'other_nol64': {'tests': ['a11yr', 09:15:00 INFO - 'ts_paint', 09:15:00 INFO - 'tpaint', 09:15:00 INFO - 'sessionrestore', 09:15:00 INFO - 'sessionrestore_no_auto_restore']}, 09:15:00 INFO - 'svgr': {'tests': ['tsvgx', 09:15:00 INFO - 'tsvgr_opacity', 09:15:00 INFO - 'tart', 09:15:00 INFO - 'tscrollx', 09:15:00 INFO - 'cart']}, 09:15:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:15:00 INFO - 'tests': ['tsvgx', 09:15:00 INFO - 'tsvgr_opacity', 09:15:00 INFO - 'tart', 09:15:00 INFO - 'tscrollx', 09:15:00 INFO - 'cart']}, 09:15:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:00 INFO - 'tests': ['tp5o']}, 09:15:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:00 INFO - 'talos_options': ['--e10s'], 09:15:00 INFO - 'tests': ['tp5o']}, 09:15:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:00 INFO - 'talos_options': ['--xperf_path', 09:15:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:00 INFO - 'tests': ['tp5n']}, 09:15:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:00 INFO - 'talos_options': ['--e10s', 09:15:00 INFO - '--xperf_path', 09:15:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:00 INFO - 'tests': ['tp5n']}}, 09:15:00 INFO - 'talos.zip': {'path': '', 09:15:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:15:00 INFO - Running post-action listener: _resource_record_post_action 09:15:00 INFO - ##### 09:15:00 INFO - ##### Running create-virtualenv step. 09:15:00 INFO - ##### 09:15:00 INFO - Running pre-action listener: _resource_record_pre_action 09:15:00 INFO - Running main action method: create_virtualenv 09:15:00 INFO - Creating virtualenv /builds/slave/test/build/venv 09:15:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:15:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:15:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:15:00 INFO - Using real prefix '/usr' 09:15:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:15:00 INFO - Installing distribute.............................................................................................................................................................................................done. 09:15:02 INFO - Installing pip.................done. 09:15:02 INFO - Return code: 0 09:15:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:15:02 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')]} 09:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:02 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')]} 09:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38cd45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c690b0>, '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 0x1c69fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:15:02 INFO - Using env: {'DISPLAY': ':0', 09:15:02 INFO - 'HOME': '/home/cltbld', 09:15:02 INFO - 'LANG': 'en_US.UTF-8', 09:15:02 INFO - 'LANGUAGE': 'en_US:en', 09:15:02 INFO - 'LOGNAME': 'cltbld', 09:15:02 INFO - 'MAIL': '/var/mail/cltbld', 09:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:02 INFO - 'MOZ_NO_REMOTE': '1', 09:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:02 INFO - 'NO_EM_RESTART': '1', 09:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:02 INFO - 'PWD': '/builds/slave/test', 09:15:02 INFO - 'SHELL': '/bin/bash', 09:15:02 INFO - 'SHLVL': '1', 09:15:02 INFO - 'TERM': 'linux', 09:15:02 INFO - 'TMOUT': '86400', 09:15:02 INFO - 'USER': 'cltbld', 09:15:02 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', 09:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:02 INFO - '_': '/tools/buildbot/bin/python'} 09:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:02 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 09:15:02 INFO - Cleaning up... 09:15:02 INFO - Return code: 0 09:15:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:15:02 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')]} 09:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:02 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')]} 09:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38cd45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c690b0>, '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 0x1c69fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:15:02 INFO - Using env: {'DISPLAY': ':0', 09:15:02 INFO - 'HOME': '/home/cltbld', 09:15:02 INFO - 'LANG': 'en_US.UTF-8', 09:15:02 INFO - 'LANGUAGE': 'en_US:en', 09:15:02 INFO - 'LOGNAME': 'cltbld', 09:15:02 INFO - 'MAIL': '/var/mail/cltbld', 09:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:02 INFO - 'MOZ_NO_REMOTE': '1', 09:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:02 INFO - 'NO_EM_RESTART': '1', 09:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:02 INFO - 'PWD': '/builds/slave/test', 09:15:02 INFO - 'SHELL': '/bin/bash', 09:15:02 INFO - 'SHLVL': '1', 09:15:02 INFO - 'TERM': 'linux', 09:15:02 INFO - 'TMOUT': '86400', 09:15:02 INFO - 'USER': 'cltbld', 09:15:02 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', 09:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:02 INFO - '_': '/tools/buildbot/bin/python'} 09:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:03 INFO - Downloading/unpacking psutil>=0.7.1 09:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:15:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:15:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:05 INFO - Installing collected packages: psutil 09:15:05 INFO - Running setup.py install for psutil 09:15:05 INFO - building 'psutil._psutil_linux' extension 09:15:05 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 09:15:05 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 09:15:05 INFO - building 'psutil._psutil_posix' extension 09:15:05 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 09:15:05 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 09:15:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:05 INFO - Successfully installed psutil 09:15:05 INFO - Cleaning up... 09:15:05 INFO - Return code: 0 09:15:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:15:05 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')]} 09:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:05 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')]} 09:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38cd45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c690b0>, '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 0x1c69fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:15:05 INFO - Using env: {'DISPLAY': ':0', 09:15:05 INFO - 'HOME': '/home/cltbld', 09:15:05 INFO - 'LANG': 'en_US.UTF-8', 09:15:05 INFO - 'LANGUAGE': 'en_US:en', 09:15:05 INFO - 'LOGNAME': 'cltbld', 09:15:05 INFO - 'MAIL': '/var/mail/cltbld', 09:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:05 INFO - 'MOZ_NO_REMOTE': '1', 09:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:05 INFO - 'NO_EM_RESTART': '1', 09:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:05 INFO - 'PWD': '/builds/slave/test', 09:15:05 INFO - 'SHELL': '/bin/bash', 09:15:05 INFO - 'SHLVL': '1', 09:15:05 INFO - 'TERM': 'linux', 09:15:05 INFO - 'TMOUT': '86400', 09:15:05 INFO - 'USER': 'cltbld', 09:15:05 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', 09:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:05 INFO - '_': '/tools/buildbot/bin/python'} 09:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:15:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:15:07 INFO - Installing collected packages: mozsystemmonitor 09:15:07 INFO - Running setup.py install for mozsystemmonitor 09:15:07 INFO - Successfully installed mozsystemmonitor 09:15:07 INFO - Cleaning up... 09:15:07 INFO - Return code: 0 09:15:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:15:07 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')]} 09:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:07 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')]} 09:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38cd45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c690b0>, '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 0x1c69fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:15:07 INFO - Using env: {'DISPLAY': ':0', 09:15:07 INFO - 'HOME': '/home/cltbld', 09:15:07 INFO - 'LANG': 'en_US.UTF-8', 09:15:07 INFO - 'LANGUAGE': 'en_US:en', 09:15:07 INFO - 'LOGNAME': 'cltbld', 09:15:07 INFO - 'MAIL': '/var/mail/cltbld', 09:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:07 INFO - 'MOZ_NO_REMOTE': '1', 09:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:07 INFO - 'NO_EM_RESTART': '1', 09:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:07 INFO - 'PWD': '/builds/slave/test', 09:15:07 INFO - 'SHELL': '/bin/bash', 09:15:07 INFO - 'SHLVL': '1', 09:15:07 INFO - 'TERM': 'linux', 09:15:07 INFO - 'TMOUT': '86400', 09:15:07 INFO - 'USER': 'cltbld', 09:15:07 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', 09:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:07 INFO - '_': '/tools/buildbot/bin/python'} 09:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:08 INFO - Downloading/unpacking blobuploader==1.2.4 09:15:08 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 09:15:08 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 09:15:08 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 09:15:08 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 09:15:08 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 09:15:08 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 09:15:09 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:15:09 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 09:15:09 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 09:15:09 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 09:15:09 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 09:15:09 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 09:15:09 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 09:15:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:15:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:10 INFO - Downloading docopt-0.6.1.tar.gz 09:15:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:10 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:10 INFO - Running setup.py install for blobuploader 09:15:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:15:10 INFO - Running setup.py install for requests 09:15:10 INFO - Running setup.py install for docopt 09:15:10 INFO - Successfully installed blobuploader requests docopt 09:15:10 INFO - Cleaning up... 09:15:11 INFO - Return code: 0 09:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:11 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')]} 09:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:11 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')]} 09:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fc38cd45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c690b0>, '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 0x1c69fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:15:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 09:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 09:15:11 INFO - Using env: {'DISPLAY': ':0', 09:15:11 INFO - 'HOME': '/home/cltbld', 09:15:11 INFO - 'LANG': 'en_US.UTF-8', 09:15:11 INFO - 'LANGUAGE': 'en_US:en', 09:15:11 INFO - 'LOGNAME': 'cltbld', 09:15:11 INFO - 'MAIL': '/var/mail/cltbld', 09:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:11 INFO - 'MOZ_NO_REMOTE': '1', 09:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:11 INFO - 'NO_EM_RESTART': '1', 09:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:11 INFO - 'PWD': '/builds/slave/test', 09:15:11 INFO - 'SHELL': '/bin/bash', 09:15:11 INFO - 'SHLVL': '1', 09:15:11 INFO - 'TERM': 'linux', 09:15:11 INFO - 'TMOUT': '86400', 09:15:11 INFO - 'USER': 'cltbld', 09:15:11 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', 09:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:11 INFO - '_': '/tools/buildbot/bin/python'} 09:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:11 INFO - Running setup.py (path:/tmp/pip-IlLtdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:11 INFO - Running setup.py (path:/tmp/pip-kSc3bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:11 INFO - Running setup.py (path:/tmp/pip-Vwswov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:11 INFO - Running setup.py (path:/tmp/pip-JoOOQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:11 INFO - Running setup.py (path:/tmp/pip-bOsSw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:11 INFO - Running setup.py (path:/tmp/pip-KZWy7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:11 INFO - Running setup.py (path:/tmp/pip-sXxVtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:11 INFO - Running setup.py (path:/tmp/pip-b5WeM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:11 INFO - Running setup.py (path:/tmp/pip-5dnOZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:11 INFO - Running setup.py (path:/tmp/pip-7wcz93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:11 INFO - Running setup.py (path:/tmp/pip-zQo4fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:12 INFO - Running setup.py (path:/tmp/pip-H8Quas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:12 INFO - Running setup.py (path:/tmp/pip-O7F7Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:12 INFO - Running setup.py (path:/tmp/pip-Eko1yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:12 INFO - Running setup.py (path:/tmp/pip-alljEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:12 INFO - Running setup.py (path:/tmp/pip-3ERHTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:12 INFO - Running setup.py (path:/tmp/pip-02VtqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:12 INFO - Running setup.py install for manifestparser 09:15:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for mozcrash 09:15:12 INFO - Running setup.py install for mozdebug 09:15:12 INFO - Running setup.py install for mozdevice 09:15:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for mozfile 09:15:12 INFO - Running setup.py install for mozhttpd 09:15:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Running setup.py install for mozinfo 09:15:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Running setup.py install for mozInstall 09:15:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Running setup.py install for mozleak 09:15:13 INFO - Running setup.py install for mozlog 09:15:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Running setup.py install for moznetwork 09:15:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Running setup.py install for mozprocess 09:15:13 INFO - Running setup.py install for mozprofile 09:15:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Running setup.py install for mozrunner 09:15:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Running setup.py install for mozscreenshot 09:15:13 INFO - Running setup.py install for moztest 09:15:14 INFO - Running setup.py install for mozversion 09:15:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:15:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:15:14 INFO - Cleaning up... 09:15:14 INFO - Return code: 0 09:15:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:14 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')]} 09:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:14 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')]} 09:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fc38cd45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c690b0>, '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 0x1c69fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 09:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 09:15:14 INFO - Using env: {'DISPLAY': ':0', 09:15:14 INFO - 'HOME': '/home/cltbld', 09:15:14 INFO - 'LANG': 'en_US.UTF-8', 09:15:14 INFO - 'LANGUAGE': 'en_US:en', 09:15:14 INFO - 'LOGNAME': 'cltbld', 09:15:14 INFO - 'MAIL': '/var/mail/cltbld', 09:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:14 INFO - 'MOZ_NO_REMOTE': '1', 09:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:14 INFO - 'NO_EM_RESTART': '1', 09:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:14 INFO - 'PWD': '/builds/slave/test', 09:15:14 INFO - 'SHELL': '/bin/bash', 09:15:14 INFO - 'SHLVL': '1', 09:15:14 INFO - 'TERM': 'linux', 09:15:14 INFO - 'TMOUT': '86400', 09:15:14 INFO - 'USER': 'cltbld', 09:15:14 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', 09:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:14 INFO - '_': '/tools/buildbot/bin/python'} 09:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:14 INFO - Running setup.py (path:/tmp/pip-T97Nuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:14 INFO - Running setup.py (path:/tmp/pip-P1uotB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:14 INFO - Running setup.py (path:/tmp/pip-Ul5EF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:14 INFO - Running setup.py (path:/tmp/pip-IqVkyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:14 INFO - Running setup.py (path:/tmp/pip-fKlOSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:14 INFO - Running setup.py (path:/tmp/pip-v3Hb7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:14 INFO - Running setup.py (path:/tmp/pip-HH2AXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:14 INFO - Running setup.py (path:/tmp/pip-QQEcsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:15 INFO - Running setup.py (path:/tmp/pip-qCWi9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:15 INFO - Running setup.py (path:/tmp/pip-KrAtFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:15 INFO - Running setup.py (path:/tmp/pip-WlRcuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:15 INFO - Running setup.py (path:/tmp/pip-Tc8QmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:15 INFO - Running setup.py (path:/tmp/pip-ExzHTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:15 INFO - Running setup.py (path:/tmp/pip-vJq0WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:15 INFO - Running setup.py (path:/tmp/pip-iu5kwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:15 INFO - Running setup.py (path:/tmp/pip-EUbbT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:15 INFO - Running setup.py (path:/tmp/pip-YhgbFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:15:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:17 INFO - Downloading blessings-1.5.1.tar.gz 09:15:17 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:17 INFO - Installing collected packages: blessings 09:15:17 INFO - Running setup.py install for blessings 09:15:17 INFO - Successfully installed blessings 09:15:17 INFO - Cleaning up... 09:15:17 INFO - Return code: 0 09:15:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:15:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:17 INFO - Reading from file tmpfile_stdout 09:15:17 INFO - Current package versions: 09:15:17 INFO - argparse == 1.2.1 09:15:17 INFO - blessings == 1.5.1 09:15:17 INFO - blobuploader == 1.2.4 09:15:17 INFO - docopt == 0.6.1 09:15:17 INFO - manifestparser == 1.1 09:15:17 INFO - mozInstall == 1.12 09:15:17 INFO - mozcrash == 0.16 09:15:17 INFO - mozdebug == 0.1 09:15:17 INFO - mozdevice == 0.47 09:15:17 INFO - mozfile == 1.2 09:15:17 INFO - mozhttpd == 0.7 09:15:17 INFO - mozinfo == 0.9 09:15:17 INFO - mozleak == 0.1 09:15:17 INFO - mozlog == 3.1 09:15:17 INFO - moznetwork == 0.27 09:15:17 INFO - mozprocess == 0.22 09:15:17 INFO - mozprofile == 0.27 09:15:17 INFO - mozrunner == 6.11 09:15:17 INFO - mozscreenshot == 0.1 09:15:17 INFO - mozsystemmonitor == 0.0 09:15:17 INFO - moztest == 0.7 09:15:17 INFO - mozversion == 1.4 09:15:17 INFO - psutil == 3.1.1 09:15:17 INFO - requests == 1.2.3 09:15:17 INFO - wsgiref == 0.1.2 09:15:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fc38cd45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c690b0>, '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 0x1c69fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 09:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 09:15:17 INFO - Using env: {'DISPLAY': ':0', 09:15:17 INFO - 'HOME': '/home/cltbld', 09:15:17 INFO - 'LANG': 'en_US.UTF-8', 09:15:17 INFO - 'LANGUAGE': 'en_US:en', 09:15:17 INFO - 'LOGNAME': 'cltbld', 09:15:17 INFO - 'MAIL': '/var/mail/cltbld', 09:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:17 INFO - 'MOZ_NO_REMOTE': '1', 09:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:17 INFO - 'NO_EM_RESTART': '1', 09:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:17 INFO - 'PWD': '/builds/slave/test', 09:15:17 INFO - 'SHELL': '/bin/bash', 09:15:17 INFO - 'SHLVL': '1', 09:15:17 INFO - 'TERM': 'linux', 09:15:17 INFO - 'TMOUT': '86400', 09:15:17 INFO - 'USER': 'cltbld', 09:15:17 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', 09:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:17 INFO - '_': '/tools/buildbot/bin/python'} 09:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:15:17 INFO - Cleaning up... 09:15:18 INFO - Return code: 0 09:15:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38cd45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c690b0>, '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 0x1c69fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:15:18 INFO - Using env: {'DISPLAY': ':0', 09:15:18 INFO - 'HOME': '/home/cltbld', 09:15:18 INFO - 'LANG': 'en_US.UTF-8', 09:15:18 INFO - 'LANGUAGE': 'en_US:en', 09:15:18 INFO - 'LOGNAME': 'cltbld', 09:15:18 INFO - 'MAIL': '/var/mail/cltbld', 09:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:18 INFO - 'MOZ_NO_REMOTE': '1', 09:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:18 INFO - 'NO_EM_RESTART': '1', 09:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:18 INFO - 'PWD': '/builds/slave/test', 09:15:18 INFO - 'SHELL': '/bin/bash', 09:15:18 INFO - 'SHLVL': '1', 09:15:18 INFO - 'TERM': 'linux', 09:15:18 INFO - 'TMOUT': '86400', 09:15:18 INFO - 'USER': 'cltbld', 09:15:18 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', 09:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:18 INFO - '_': '/tools/buildbot/bin/python'} 09:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:18 INFO - Downloading/unpacking jsonschema 09:15:18 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 09:15:18 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 09:15:18 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 09:15:18 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 09:15:18 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 09:15:18 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 09:15:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 09:15:19 INFO - Downloading/unpacking functools32 (from jsonschema) 09:15:19 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 09:15:19 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 09:15:19 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 09:15:19 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 09:15:19 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 09:15:19 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 09:15:20 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:20 INFO - warning: no files found matching '*.txt' 09:15:20 INFO - no previously-included directories found matching 'build' 09:15:20 INFO - no previously-included directories found matching 'dist' 09:15:20 INFO - no previously-included directories found matching '.git*' 09:15:20 INFO - Installing collected packages: jsonschema, functools32 09:15:20 INFO - Running setup.py install for functools32 09:15:20 INFO - warning: no files found matching '*.txt' 09:15:20 INFO - no previously-included directories found matching 'build' 09:15:20 INFO - no previously-included directories found matching 'dist' 09:15:20 INFO - no previously-included directories found matching '.git*' 09:15:20 INFO - Successfully installed jsonschema functools32 09:15:20 INFO - Cleaning up... 09:15:20 INFO - Return code: 0 09:15:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38cd45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c690b0>, '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 0x1c69fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 09:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:15:20 INFO - Using env: {'DISPLAY': ':0', 09:15:20 INFO - 'HOME': '/home/cltbld', 09:15:20 INFO - 'LANG': 'en_US.UTF-8', 09:15:20 INFO - 'LANGUAGE': 'en_US:en', 09:15:20 INFO - 'LOGNAME': 'cltbld', 09:15:20 INFO - 'MAIL': '/var/mail/cltbld', 09:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:20 INFO - 'MOZ_NO_REMOTE': '1', 09:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:20 INFO - 'NO_EM_RESTART': '1', 09:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:20 INFO - 'PWD': '/builds/slave/test', 09:15:20 INFO - 'SHELL': '/bin/bash', 09:15:20 INFO - 'SHLVL': '1', 09:15:20 INFO - 'TERM': 'linux', 09:15:20 INFO - 'TMOUT': '86400', 09:15:20 INFO - 'USER': 'cltbld', 09:15:20 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', 09:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:20 INFO - '_': '/tools/buildbot/bin/python'} 09:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:20 INFO - Downloading/unpacking flake8 09:15:20 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 09:15:20 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 09:15:20 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 09:15:20 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 09:15:20 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 09:15:20 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 09:15:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:15:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 09:15:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:15:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 09:15:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 09:15:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:15:22 INFO - no previously-included directories found matching 'docs/_build' 09:15:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:15:22 INFO - Running setup.py install for pep8 09:15:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:15:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:15:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:15:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:15:23 INFO - no previously-included directories found matching 'docs/_build' 09:15:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:15:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:15:23 INFO - Cleaning up... 09:15:23 INFO - Return code: 0 09:15:23 INFO - Running post-action listener: _resource_record_post_action 09:15:23 INFO - Running post-action listener: _start_resource_monitoring 09:15:23 INFO - Starting resource monitoring. 09:15:23 INFO - ##### 09:15:23 INFO - ##### Running install step. 09:15:23 INFO - ##### 09:15:23 INFO - Running pre-action listener: _resource_record_pre_action 09:15:23 INFO - Running main action method: install 09:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:23 INFO - Reading from file tmpfile_stdout 09:15:23 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:15:23 INFO - Reading from file tmpfile_stdout 09:15:23 INFO - Output received: 09:15:23 INFO - Usage: mozinstall [options] installer 09:15:23 INFO - Options: 09:15:23 INFO - -h, --help show this help message and exit 09:15:23 INFO - -d DEST, --destination=DEST 09:15:23 INFO - Directory to install application into. [default: 09:15:23 INFO - "/builds/slave/test"] 09:15:23 INFO - --app=APP Application being installed. [default: firefox] 09:15:23 INFO - mkdir: /builds/slave/test/build/application 09:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:15:38 INFO - Reading from file tmpfile_stdout 09:15:38 INFO - Output received: 09:15:38 INFO - /builds/slave/test/build/application/firefox/firefox 09:15:38 INFO - Running post-action listener: _resource_record_post_action 09:15:38 INFO - ##### 09:15:38 INFO - ##### Running run-tests step. 09:15:38 INFO - ##### 09:15:38 INFO - Running pre-action listener: _resource_record_pre_action 09:15:38 INFO - Running main action method: run_tests 09:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:15:38 INFO - Python 2.7.3 09:15:38 INFO - Return code: 0 09:15:38 INFO - grabbing minidump binary from tooltool 09:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:38 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/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 0x1c690b0>, '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 0x1c69fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:15:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:15:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:15:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:15:38 INFO - Return code: 0 09:15:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:15:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:15:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:15:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:15:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:15:39 INFO - Return code: 0 09:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test/build 09:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 09:15:39 INFO - Using env: {'DISPLAY': ':0', 09:15:39 INFO - 'HOME': '/home/cltbld', 09:15:39 INFO - 'LANG': 'en_US.UTF-8', 09:15:39 INFO - 'LANGUAGE': 'en_US:en', 09:15:39 INFO - 'LOGNAME': 'cltbld', 09:15:39 INFO - 'MAIL': '/var/mail/cltbld', 09:15:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:15:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:39 INFO - 'MOZ_NO_REMOTE': '1', 09:15:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:39 INFO - 'NO_EM_RESTART': '1', 09:15:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:39 INFO - 'PWD': '/builds/slave/test', 09:15:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:15:39 INFO - 'SHELL': '/bin/bash', 09:15:39 INFO - 'SHLVL': '1', 09:15:39 INFO - 'TERM': 'linux', 09:15:39 INFO - 'TMOUT': '86400', 09:15:39 INFO - 'USER': 'cltbld', 09:15:39 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666', 09:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:39 INFO - '_': '/tools/buildbot/bin/python'} 09:15:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 09:15:40 INFO - mozversion INFO | application_buildid: 20151218082856 09:15:40 INFO - mozversion INFO | application_changeset: 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 09:15:40 INFO - mozversion INFO | application_display_name: Nightly 09:15:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:15:40 INFO - mozversion INFO | application_name: Firefox 09:15:40 INFO - mozversion INFO | application_remotingname: firefox 09:15:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:15:40 INFO - mozversion INFO | application_vendor: Mozilla 09:15:40 INFO - mozversion INFO | application_version: 46.0a1 09:15:40 INFO - mozversion INFO | platform_buildid: 20151218082856 09:15:40 INFO - mozversion INFO | platform_changeset: 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 09:15:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:15:40 INFO - mozversion INFO | platform_version: 46.0a1 09:15:40 INFO - 2015-12-18 09:15:40,035 DEBUG : using testdate: 1450458940 09:15:40 INFO - 2015-12-18 09:15:40,035 DEBUG : actual date: 1450458940 09:15:40 INFO - 2015-12-18 09:15:40,109 INFO : starting webserver on 'localhost:33004' 09:15:40 INFO - 2015-12-18 09:15:40,109 INFO : Starting test suite talos-linux64-ix-036 09:15:40 INFO - 2015-12-18 09:15:40,110 INFO : Starting test dromaeo_css 09:15:40 INFO - 2015-12-18 09:15:40,110 DEBUG : operating with platform_type : linux_ 09:15:40 INFO - 2015-12-18 09:15:40,110 INFO : Initialising browser for dromaeo_css test... 09:15:40 INFO - 2015-12-18 09:15:40,127 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL8f_Gj/profile http://localhost:33004/getInfo.html 09:15:45 INFO - 2015-12-18 09:15:45,339 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:15:45 INFO - 2015-12-18 09:15:45,339 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:15:45 INFO - 2015-12-18 09:15:45,339 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:15:45 INFO - 2015-12-18 09:15:45,339 DEBUG : BROWSER_OUTPUT: __metrics 09:15:45 INFO - 2015-12-18 09:15:45,476 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:15:45 INFO - 2015-12-18 09:15:45,532 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:46 INFO - 2015-12-18 09:15:46,547 INFO : Browser initialized. 09:15:46 INFO - 2015-12-18 09:15:46,548 INFO : Running cycle 1/1 for dromaeo_css test... 09:15:46 INFO - 2015-12-18 09:15:46,548 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL8f_Gj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:15:58 INFO - 2015-12-18 09:15:58,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 150372352 09:15:58 INFO - 2015-12-18 09:15:58,510 DEBUG : BROWSER_OUTPUT: 09:16:49 INFO - 2015-12-18 09:16:49,780 DEBUG : BROWSER_OUTPUT: 1450459009772 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] 09:19:02 INFO - 2015-12-18 09:19:02,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33004/tests/dromaeo/cssquery-ext.html) 09:19:03 INFO - 2015-12-18 09:19:03,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 256409600 09:19:03 INFO - 2015-12-18 09:19:03,314 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-12-18 09:22:05,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/dromaeo/cssquery-ext.html (next: http://localhost:33004/tests/dromaeo/cssquery-jquery.html) 09:22:06 INFO - 2015-12-18 09:22:06,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 232361984 09:22:06 INFO - 2015-12-18 09:22:06,539 DEBUG : BROWSER_OUTPUT: 09:25:08 INFO - 2015-12-18 09:25:08,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33004/tests/dromaeo/cssquery-mootools.html) 09:25:09 INFO - 2015-12-18 09:25:09,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 229507072 09:25:09 INFO - 2015-12-18 09:25:09,208 DEBUG : BROWSER_OUTPUT: 09:28:11 INFO - 2015-12-18 09:28:11,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33004/tests/dromaeo/cssquery-prototype.html) 09:28:11 INFO - 2015-12-18 09:28:11,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 214159360 09:28:11 INFO - 2015-12-18 09:28:11,740 DEBUG : BROWSER_OUTPUT: 09:31:14 INFO - 2015-12-18 09:31:14,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33004/tests/dromaeo/cssquery-yui.html) 09:31:15 INFO - 2015-12-18 09:31:15,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 216346624 09:31:15 INFO - 2015-12-18 09:31:15,078 DEBUG : BROWSER_OUTPUT: 09:34:17 INFO - 2015-12-18 09:34:17,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/dromaeo/cssquery-yui.html (next: http://localhost:33004/tests/dromaeo/cssquery-dojo.html) 09:34:17 INFO - 2015-12-18 09:34:17,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 261808128 09:34:17 INFO - 2015-12-18 09:34:17,824 DEBUG : BROWSER_OUTPUT: 09:34:17 INFO - 2015-12-18 09:34:17,824 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:34:17 INFO - 2015-12-18 09:34:17,824 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:34:17 INFO - 2015-12-18 09:34:17,824 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:34:17 INFO - 2015-12-18 09:34:17,825 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:34:17 INFO - 2015-12-18 09:34:17,825 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2619.751123643254;2696.23157400141;2711.362829735012;2714.158610830643;2727.1000569811963;4427.77861106945;4599.88500287493;4647.3029045643125;4719.103370359633;4729.077829823186;4626.514216007321;4708.7645617719145;4708.835190768324;4745.549172828584;4906.190478571031;4340.761258130801;4349.934750978738;4357.237483440385;4357.43353364063;4432.047109871377;4150.211459822624;4494.438195225597;4515.300128480075;4536.931946020813;4551;4283.3146696528565;4297.247981603207;4374.081442896995;4394.60448559628;4416.779161041935;4320.870373888788;4320.978395108035;4343.2182207202695;4370.082282720632;4380.255356589356;4299.419578356944;4310.3103503439615;4314;4360.585744354281;4362.36745671879;4452.532484089189;4579.267317229227;4586.472555656109;4654.953450465486;4750.097481478542;5034.14419548674;5034.395872495287;5035.748212589392;5045.823396181116;5080.13637681595;5033.924491132636;5042.873928151826;5063.139266324733;5065.620078494091;5081.66969147008;4507.774611269423;4607.032523170172;4608.815647374101;4712.976435117871;4842.539958703917;5237.397699264558;5260.026895024433;5261.842144735664;5265.7103859287345;5266.973665131726;5039.042581909499;5046.318746969186;5051.974740126276;5052.9242061369105;5077.416097148801;4881.95118048822;4928.67963582366;4993.80024799004;4995.275685025651;5017.222330538772;5066.46802085783;5075.695458272516;5079.288899554065;5081.74591270435;5131.384233891882;5059.06407314648;5061.089003979319;5062.215356619729;5064.1897296433135;5069.340985671839;4010.0776821331256;4071.5521292657786;4115.259253334369;4117.608827161415;4222.577742225814;3746.1758413149064;3750.83121259544;3759.266942946154;3776.0937375029794;3813.5423749149722;4400.713953593006;4406.889827754268;4419.734815911055;4421.668374871898;4461.866144015685;4881.633877459205;4999.65002449825;5008;5177.8187763428095;5200.089984252816;4322.832835134496;4374.4531933508315;4385.144896745168;4426.557344265548;4433.046894917544;4479.238529450001;4540.659450541157;4588.128255631419;4602.309653551927;4640.814367425332;4606.88482787933;4716.221823399101;4721.4570324413135;4850.029994001214;4859.781309841136;5084.440711521804;5129.204973229155;5144.228365745168;5148.97425512885;5193.68837869729;4764.49972752856;4807.6394270429155;4808.966072294474;4812.398450193726;4852.102361063215;4758.714477131383;4844.636652251025;4855.6115510758345;5022.422421421583;5079.3650793650795;4964.205727083649;5035.420926593342;5073.137566613611;5078.695278283167;5120.001599688025;4936.259561065725;4950.282209079592;4950.975245123751;4956.727379994135;4998.525140111684;4772.284157376422;4893.853184404474;4908.803647854189;4945.851624451272;4996.475370086088;4697.530246975275;4789.042191561632;4873.878153046202;4883.975580122076;4896.387951506062;4931.7040977541465;4959.504049595012;4963.851084467472;4967.111146439936;5008;4643.86068417948;4783.6651434399255;4849.9815038842235;4866.221404575251;4872.9512704872495 09:34:17 INFO - 2015-12-18 09:34:17,826 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.258000729041;569.4305694305694;569.444791328455;571.851318657149;573.8450618333051;26274.2117736468;35201.64798352015;35398.823005884966;35477.82261088691;35503.64496355036;39717.205655886864;39955.800220998855;40047.799761001224;40198;40314.39528407069;6855.828604284883;6933.1333583302085;7674.846503069935;7826.178251283619;7827.7260295889655;9989.600415983388;10207.234457415687;10211.642592509264;10211.744706382362;10215.795684086313;9650.469224192666;9795.510224488782;9795.657151999681;9801.950990245039;9803;7117.679704413288;7256.310650488195;9637.759056023586;10051.648192313234;10284.43435611041;9686.564104615309;9834.754131146707;9841.114299712988;9845.606175753033;9849.458279794608;29597;36607.63392366069;37113;37138.814305928296;37152;2336.2874323331375;2916.066858605247;2920.7225313595172;2960.866760995739;2994.6107006089287;26216.73783262162;26488.60267095995;26580;26627.600585991226;27137.864310678517;3281.3273278977754;3298.422776014212;3322.933541329184;3374.5950485941844;3382.374260761767;173452;173715;175075;175135;175365;47698.28452573214;48211.491448654684;48986.75506622444;49746;52168.43557684115;46200.537994620296;46359.768201158775;46375.53624463712;46375.5362446378;46740.29889551659;13261.93369033168;13388.665283367995;13448.596542103556;13456.663583410298;13462.932685336511;10724.356538607552;10798.352098874093;10816.134709223243;10828.404437755842;10830.566777328977;17543;17630.647387052188;17669.38157164493;17812.287508499776;17871.463856084338;6946;7185.784426467214;7209.279072092749;7224.819379515449;7290.744823931137;869.2394155114275;876.5660997806127;910.9074691422584;992.389680346596;997.4613708597421;25621.48757024849;26501.867490662422;26532.204033879014;26917.327066823094;27219.319517012234;917.8026724254318;954.5752140297501;958.1759686669459;966.8549717542425;982.4007355513131;12106.455209515592;12165.817512737316;12316.322602256783;12388.442520086617;12458.190217635825;266154;268351;270154;270312;270788;43724.78137609355;43829.78085109618;43914;44046.559534404885;44053.33919991203;1215.7872372334982;1219.5792451604004;1223.1865809236758;1227.7298994221258;1232.1559731583893;23195.6520652187;23221.41946451352;26008.21975340743;26826.731732682423;28329.291767705974;38140.809295953346;38547;38567.42148867713;38593.614063859;38680;198644;199644;199841;199921;200355;23869.283921482383;24588.631170532815;24591.38521536976;25625.39018830672;27740.445191096467;28886;29162.708372916848;30771.846140769154;34025.319493610485;34805.825970869984;28733.856330718212;29460.705392945798;30606.846965765028;30896.69103309028;30937.69062309348;30414.239644009078;30662.693373066875;30742.53886191664;30752.384952301276;30787;30306.090817275515;31409.842950786013;31457.528137077505;31496;31625.525617116222;26135.869320653273;28113.859430702716;28237.717622823508;28247.717522824507;28268;21540.246091386725;22136.557268854856;22148.77851221467;22171.55656886821;22212.88893555522 09:34:17 INFO - 2015-12-18 09:34:17,826 DEBUG : BROWSER_OUTPUT: |2;jquery.html;316.68331668331666;321.7040322902929;327.3714468221015;331.62691971532035;334.1262598305431;12409.131360804748;12745.872541274608;14680.77978830317;15185.620359491018;15852.524424267276;13092.34538273085;13456;13456.394462249198;14939.92530037351;15379.154146521936;3678.7057035437233;4439.356293337481;4499.325101234825;4626.65300102492;5060.79756809729;3449.3273811606746;3553.1472446612756;5013.047520971022;5159.819406320779;5321.201819727053;5246.580273578104;5278.261043453919;5285.656432331905;5299.54953828925;5303.124984377573;5155.252488389181;5248.81629142982;5263.394709608387;5287.629865909388;5298.92051619226;5177.042247184283;5198.636095473318;5198.974005129988;5201.557867581222;5204.401493828221;11485.483153258123;11908.225965312227;11908.523659053628;11927.343996080212;11927.940360298144;1737.0533059482611;1789.1412122181296;1854.1934258597553;1869.9439016829517;1974.0721860725437;8685.609147588311;8792;8843.425177363451;8968.327375446868;9148.313876459291;1729.2564197395116;1736.1145815634118;1743.5205318537378;1754.9473515794546;1768.3633891798943;53718.73140634272;55138.448615513735;55509.44490555083;55792.442075579536;56495.15257271144;9751.902480975099;9762.511874406393;9806.166475849634;9813.950930245303;9831.655892043887;12506.187097838794;12520.248785072925;12528.498860045678;12537.122401431994;12548.435320410603;6711.496637752188;6898.896516552256;6997.160340759141;7050.365467107985;7136.7145314186855;6890.758823441155;6894.689738961759;6898.379145876896;6953.860922781617;6969.30306969299;4138.482689663792;4146.937795933063;4177.4778152730905;4183.3515805050265;4205.3481710334945;1638.860696840758;1673.2972151696317;1676.5640933357415;1678.7481877718196;1701.6936951348628;684.6234570985938;864.6498168241872;867.8481265778463;925.6204955968021;935.5275585829113;15502.9224853875;15668.216589170495;15856.60358491047;16245.187740612922;16276.43032493857;733.0690023670016;749.3218637133403;792.0455850699893;926.0970553710214;959.9712008639752;7694.961525192338;8489.61796719149;8932.821343573092;9440.858387124199;9449.480278584606;510771;511475;519981;524030;525532;67119.32880671228;70879.64560177166;71755.6412217946;72583;73930.63034684792;1076.3488089705772;1076.6285631457135;1084.436093231531;1087.3584585094675;1093.0981939899614;14708.264586770832;14798.334074966437;14976.92511537479;15017.17405542662;15285.159316237714;33459.163520912174;33579.66420335863;33820.830895846346;33850.153746156546;33992.83003584966;45253;46626.76686616545;47052.29421558748;47093.293600596706;47369;8936.553172341486;9142.451452912846;9208.079192080739;9208.401453905475;9210.723678289662;10578.206634502289;12001.459934303151;16522.926009809325;16551.586210344358;16648.83351166473;12811.80782288285;13060;13101.672458188621;13161.53934612284;13588.660283492596;12628;12993.285369304778;13121.524390545892;13623.591292261248;13727.519536816164;13218.801717974431;13400.463981440633;13637;13864.445422183;14138.78791818103;6812.795616131524;8753.64985400577;8843.248323892542;8856.911430885608;8874.822503549763;12599.496020159091;12800.487980480677;12906.161099528501;13006.609801705965;13203.66990825237 09:34:17 INFO - 2015-12-18 09:34:17,829 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1480.1415179196067;1609.106945645167;1688.4006177806878;1693.280355848764;1735.6962531556983;6879.449644028478;7328.743493977712;7347.522411043292;7355.117385913684;7357.779266622003;7223.747168849091;7277.2722727727205;7288.416926645868;7298.598577078258;7301.89047164293;2035.8371330293614;2064.153696984237;2066.1941842681367;2066.875987440751;2067.0284966066;2072.108993132952;2138.3264271754347;2138.9358319250446;2139.475828422039;2140.1867290429614;1753.1059159828515;1788.579683774312;1791.8924864508106;2060.052375907077;2094.2460714142894;1774.3612299572208;1781.5813283878279;1978.1988294740654;2023.5952809438024;2026.6959956006717;2054.7431571053617;2062.82465990391;2074.8547601667888;2076.480879780055;2077.314486219544;5891.558133139989;7221.638918054076;7293.963530182368;7299.817504562376;7303.2331605181225;3664.193877346979;4039.7172197946156;4107.486564179478;4116.382542618601;4124.8143833527565;2666.7999900007576;2671.1719366996294;2682.3026013236504;2726.9228654681488;2728.590711393287;866.3588944181323;868.7393781865416;878.5036454403241;885.9424137431047;886.6453418632534;9724;9792.16766574842;9818.75453113678;9826.017398260188;9842.50787460624;3885.86399476017;3929.9607003929596;3961.187956468917;3978.7214894957074;4017.959820401817;8530.74407767768;8537.402381833337;8550.914490855137;8565.528895910784;8576.656933722707;4365.847195348148;4367.497737760198;4371.366151907955;4374.147041326911;4377.562243775597;3958.6041395860184;3963.4451176835264;3963.4649322341115;3966.9206615868097;3969.146633473817;3371.174062354739;3380.695737383647;3390.7626466147135;3392.5589673342306;3410.710089642408;1071.1430855315716;1074.3017038924604;1090.8963648453384;1098.2531878322818;1104.309806371018;1002.1932344462778;1014.3862962907335;1046.4140081554353;1058.6718117383482;1060.3213943076437;6671.032700258435;6744.898826517606;6770.356816102462;6770.966145169243;6774.796756097325;412.6368795460036;413.5389041219019;419.216065956663;419.92651286024824;422.0840775517135;4741.359916411309;5295.417504074549;5360.356757189084;5365.704886231295;5366.195070739421;7720.459567830198;8530.274926631306;8541.572921353907;8636.956815215884;8666.913330866737;8341.66633334672;8392.622331994953;8404.957975210085;8434.072252052269;8469.3647976402;6712.496562757715;6833.384995350343;6844.623545705034;6846.691898864563;6873.48448866327;6725.327467253432;6759.763408280686;6775.085363476065;6795.9806029096035;6810.353016463428;7581.658825352762;7765.1846556110795;7851.725189618336;7864.21357864209;7868.488548244346;7899.368050555827;7906.841863162819;8019.799505012421;8028.518288902685;8037.959810200911;5768.221290125779;6273.435390814849;6286.057091436322;6293.118963345227;6306.117143599808;6649.800505984828;6656.334366563305;6658.83352916181;6674.83312917181;6701.229358623821;6495.447886929475;6590.571612845341;6603.141591593062;6668.766593169215;6705.497087718538;6353.4599559038;6359.554831161774;6378.45783108441;6435.549511534147;6562.80311590653;6594.70323835419;6602.60384376939;6626.635535045619;6633.6019838809825;6633.734650613921;5781.075027995501;5921.200637913998;6039.214902062704;6091.42131497507;6096.329403765671;6202.782902598387;6215.254169499689;6236.6258024518675;6248.718807653576;6250.874982500415 09:34:17 INFO - 2015-12-18 09:34:17,831 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.27034306634874;302.1238408615016;306.0878581826157;310.09916193458014;310.88031108023404;5298.92051619226;5306.973465132669;5312.92030619541;5409.864753381157;5417.702026388547;5247.86880327992;5289.656172348804;5318.840434786953;5327.866803329919;5329.173978033401;4180.602842729943;4186.3092589722655;4187.790610469479;4188.371744238359;4191.853285135021;4192.218307219435;4192.7484350938885;4197.97901010496;4202.873913782591;4204.789760511962;3946.960530394688;4014.498187726534;4028.45615841862;4123.154753275571;4136.27615167346;4029.657479114279;4044.57531959143;4046.919061618751;4080.367543030835;4083.4079058536645;3528.2943411317838;3529.3823580873245;3538.2569660371355;3539.150603855082;3542.6280240574883;5163.432022477525;5172.844814655567;5180.5337519623035;5181.844544663666;5182.637215394924;4541.182587134314;4674.275487299474;4681.46163191234;4687.414073240845;4689.437267527885;5578.30271216098;5595.888082238333;5596.888062238732;5597.076482380402;5598.776048958037;3798.0504873781556;3830.2148059647707;3834.175652234755;3836.5012548368813;3837.194189220239;5638.407967163471;5697.999999999958;5785.5660825437835;5787.247657804501;5887.764489420418;3967.603239676067;3991.44119823225;3992.9600703992587;3998.4002399640285;4013.8394464221105;4024.8188831502653;4041.595840415935;4047.696422768245;4050.230456213369;4052.250333688277;4398.3402489626815;4552.1806074906835;4558.997020655451;4640.303954406866;4661.160991021581;5608.579356548275;5613.607047506635;5614.550835933115;5620.4660557247;5630.6058575900115;1403.2212122272238;1433.6702558411416;1435.4330039634285;1435.5765049310478;1435.8348789889296;950.8858936927613;956.0582825916466;958.9376690515234;974.8050389921902;977.750673578233;4934.037862616755;4945.307656928033;4948.975255123773;4952.083864485082;4952.281919121707;5846.590738648339;5847.239858818411;5848.152017957457;5849.561282903799;5854.0048191806645;4895.632827537877;4932.432770231398;4933.901321973541;4935.925961110586;4944.406671199407;3068.3709839482854;3110.7822452428113;3140.5917230759856;3146.8741250350186;3157.3527426877436;5505.697186654692;5551.084071128219;5562.221289019541;5564.165375193753;5568.805091821767;6052.66710330936;6056.06131049688;6064.514838812885;6066.45401913821;6067.7864427114755;5559.8888022239325;5560.138178582326;5565.888682226333;5569.053260945568;5570.470805273492;5709.885802284014;5844;5888.263967004124;5905.43898329658;5911.940880591311;5682.318121825242;5699.401562835843;5717.656940583412;5727.627704199213;5746.281714785652;5541.972290138524;5545.500904918576;5547.944520554743;5551;5551.250581171652;3885.3977633466857;3961.3859851723028;4024.315866302677;4025.597440255951;4036.939445908255;5669.461401166883;5820.82537523858;5836.474717275466;5841.620294680833;5841.824745257649;5546.611737178358;5671.461211184931;5691.630044047124;5700;5710.828675139753;5649.152627105803;5683.516901063456;5684.204211410489;5685.829425117253;5692.5445964321925;5431.891362172655;5555.555555555465;5559.2217089606675;5569.6936668482;5577.163425486209;5682.5453963681975;5718.085106382959;5727.341355744143;5730.742116604846;5734.913976290276;5567.053600887778;5584.190292407659;5586;5587.77648894056;5594.13290939905 09:34:17 INFO - 2015-12-18 09:34:17,832 DEBUG : BROWSER_OUTPUT: |5;yui.html;690.7685925215053;758.5486635451904;798.2217338095357;810.226233946581;823.954682492463;11010.834837477445;11117.277376970502;11161.888381116187;11181;11203.887961120407;11578.189526733133;11716.765664686702;11763.176577639568;11819.940900295507;11845.526178952832;750.4559194583924;778.8286576953061;785.6071964017991;785.8231897823001;787.9093904201004;762.1958833430729;782.2216894190288;789.1516619633887;790.5454363740844;790.6205021589641;782.6517199846071;806.0730160315654;812.8821320908494;813.4671789977574;813.6826637611337;784.6116172494624;800.5556915911667;800.8598495263305;806.479820515767;806.7216810200472;582.2866987939782;586.9354371019184;599.8920194365013;599.9250093738283;599.9850003749898;9831.262655300881;9996.700098997042;10082.647107351208;10242.53908574116;11085.27945683536;10821.729456763565;11034.779304413947;11091.944540277247;11274.661760147126;11431.771364572662;8791.692290769857;9072.591733372014;9171.082891710843;9397.483138427384;9399.34204605678;3184.1678037508877;3238.5466034755154;3239.676032396765;3258.152880251128;3319.4356959316733;36656.45015324772;37025.444618330745;37031.074223144635;37055.258894822226;37116.628833711584;8797.736067917973;9155.816883662423;9168.312376571785;9195.356325057315;9521.190698790542;15572.377104915677;15663.295151718201;15672.05967641945;15686.137262450675;15718.214089295718;6192.752289908443;6387.2891353365985;6501.934980650133;6512.144038948877;6691.832704182434;3569.5716514018486;3677.8161091945294;3691.53855768029;3699;3704.2961837250837;2547.5669136246884;2551.5279673260507;2552.4257042165364;2560.2831207261997;2564.051301018635;459.65755512143;469.8754829970061;474.34066647360197;478.05583971655705;481.0331234219245;499.7026769072396;500.06238303181533;523.494827491465;564.7345747498669;608.285264813842;7306.561606303639;7699.384049276045;7826.178251283647;7868.645910934022;7895.6052197391045;399.86804354562923;447.85220877110476;537.8268217516683;583.9532837373;604.670558798997;3567.678908898212;3651.233241019416;3697.3916346389406;3706.425504046877;3802.372608519563;47138.5286147141;48405.27392089122;48419.75790121097;48473.272900906515;48477.272840906706;43581.34627980583;43649.127017459476;44463.33305000428;44728;44953.55046449559;39688.80155599261;39898.800505997286;40137;40560.18879622391;40879.38680919789;7129.679164437509;7212.449323395495;7287.599182045038;7331.74338898136;7451.776446706607;29591;29636.555451668675;29853.701462985093;30087.247818804706;30209.69790302069;35724.28551428905;35889.64110358863;37610.43584346292;39252.60747392604;39274;10024.749381265527;10083.243756718422;10178.541965611714;10344.844827327446;10363.378197308186;11208.719782005515;11233.71915702114;11270.154738394489;11943.402829858645;12108.878911210775;10012.69961901144;10232.59069637236;10395.636152734618;10574.259801814107;11026.228164028762;9798.902010979798;9897.890735633955;10223.846642300223;10251.517952081622;10599.841002385125;10447.529861156114;10597.735056623338;10662.306950048222;10671.146308295472;10855.728606784578;8797.516136612292;8941.105889411007;8965.282777377664;9151.588178531849;9251.352405331561;8594.742157735278;9018.962819275866;9026.593803278736;9148.130927561871;9224.354295199271 09:34:17 INFO - 2015-12-18 09:34:17,832 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:34:17 INFO - 2015-12-18 09:34:17,832 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:34:17 INFO - 2015-12-18 09:34:17,832 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,999 09:34:17 INFO - 2015-12-18 09:34:17,832 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:34:17 INFO - 2015-12-18 09:34:17,832 DEBUG : BROWSER_OUTPUT: __startTimestamp1450460057821__endTimestamp 09:34:17 INFO - 2015-12-18 09:34:17,832 DEBUG : BROWSER_OUTPUT: 09:34:17 INFO - 2015-12-18 09:34:17,832 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:34:17 INFO - 2015-12-18 09:34:17,833 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:34:17 INFO - 2015-12-18 09:34:17,833 DEBUG : BROWSER_OUTPUT: 09:34:17 INFO - 2015-12-18 09:34:17,833 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4670.62 Median:4789.04 stddev:489.93 (10.2%) stddev-sans-first:464.26 09:34:17 INFO - 2015-12-18 09:34:17,833 DEBUG : BROWSER_OUTPUT: Values: 2619.8 2696.2 2711.4 2714.2 2727.1 4427.8 4599.9 4647.3 4719.1 4729.1 4626.5 4708.8 4708.8 4745.5 4906.2 4340.8 4349.9 4357.2 4357.4 4432.0 4150.2 4494.4 4515.3 4536.9 4551.0 4283.3 4297.2 4374.1 4394.6 4416.8 4320.9 4321.0 4343.2 4370.1 4380.3 4299.4 4310.3 4314.0 4360.6 4362.4 4452.5 4579.3 4586.5 4655.0 4750.1 5034.1 5034.4 5035.7 5045.8 5080.1 5033.9 5042.9 5063.1 5065.6 5081.7 4507.8 4607.0 4608.8 4713.0 4842.5 5237.4 5260.0 5261.8 5265.7 5267.0 5039.0 5046.3 5052.0 5052.9 5077.4 4882.0 4928.7 4993.8 4995.3 5017.2 5066.5 5075.7 5079.3 5081.7 5131.4 5059.1 5061.1 5062.2 5064.2 5069.3 4010.1 4071.6 4115.3 4117.6 4222.6 3746.2 3750.8 3759.3 3776.1 3813.5 4400.7 4406.9 4419.7 4421.7 4461.9 4881.6 4999.7 5008.0 5177.8 5200.1 4322.8 4374.5 4385.1 4426.6 4433.0 4479.2 4540.7 4588.1 4602.3 4640.8 4606.9 4716.2 4721.5 4850.0 4859.8 5084.4 5129.2 5144.2 5149.0 5193.7 4764.5 4807.6 4809.0 4812.4 4852.1 4758.7 4844.6 4855.6 5022.4 5079.4 4964.2 5035.4 5073.1 5078.7 5120.0 4936.3 4950.3 4951.0 4956.7 4998.5 4772.3 4893.9 4908.8 4945.9 4996.5 4697.5 4789.0 4873.9 4884.0 4896.4 4931.7 4959.5 4963.9 4967.1 5008.0 4643.9 4783.7 4850.0 4866.2 4873.0 09:34:17 INFO - 2015-12-18 09:34:17,833 DEBUG : BROWSER_OUTPUT: 09:34:17 INFO - 2015-12-18 09:34:17,833 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36815.45 Median:30702.62 stddev:56695.26 (184.7%) stddev-sans-first:56788.97 09:34:17 INFO - 2015-12-18 09:34:17,833 DEBUG : BROWSER_OUTPUT: Values: 564.3 569.4 569.4 571.9 573.8 26274.2 35201.6 35398.8 35477.8 35503.6 39717.2 39955.8 40047.8 40198.0 40314.4 6855.8 6933.1 7674.8 7826.2 7827.7 9989.6 10207.2 10211.6 10211.7 10215.8 9650.5 9795.5 9795.7 9802.0 9803.0 7117.7 7256.3 9637.8 10051.6 10284.4 9686.6 9834.8 9841.1 9845.6 9849.5 29597.0 36607.6 37113.0 37138.8 37152.0 2336.3 2916.1 2920.7 2960.9 2994.6 26216.7 26488.6 26580.0 26627.6 27137.9 3281.3 3298.4 3322.9 3374.6 3382.4 173452.0 173715.0 175075.0 175135.0 175365.0 47698.3 48211.5 48986.8 49746.0 52168.4 46200.5 46359.8 46375.5 46375.5 46740.3 13261.9 13388.7 13448.6 13456.7 13462.9 10724.4 10798.4 10816.1 10828.4 10830.6 17543.0 17630.6 17669.4 17812.3 17871.5 6946.0 7185.8 7209.3 7224.8 7290.7 869.2 876.6 910.9 992.4 997.5 25621.5 26501.9 26532.2 26917.3 27219.3 917.8 954.6 958.2 966.9 982.4 12106.5 12165.8 12316.3 12388.4 12458.2 266154.0 268351.0 270154.0 270312.0 270788.0 43724.8 43829.8 43914.0 44046.6 44053.3 1215.8 1219.6 1223.2 1227.7 1232.2 23195.7 23221.4 26008.2 26826.7 28329.3 38140.8 38547.0 38567.4 38593.6 38680.0 198644.0 199644.0 199841.0 199921.0 200355.0 23869.3 24588.6 24591.4 25625.4 27740.4 28886.0 29162.7 30771.8 34025.3 34805.8 28733.9 29460.7 30606.8 30896.7 30937.7 30414.2 30662.7 30742.5 30752.4 30787.0 30306.1 31409.8 31457.5 31496.0 31625.5 26135.9 28113.9 28237.7 28247.7 28268.0 21540.2 22136.6 22148.8 22171.6 22212.9 09:34:17 INFO - 2015-12-18 09:34:17,833 DEBUG : BROWSER_OUTPUT: 09:34:17 INFO - 2015-12-18 09:34:17,833 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27010.06 Median:4180.41 stddev:84675.13 (2025.5%) stddev-sans-first:84888.94 09:34:17 INFO - 2015-12-18 09:34:17,834 DEBUG : BROWSER_OUTPUT: Values: 316.7 321.7 327.4 331.6 334.1 12409.1 12745.9 14680.8 15185.6 15852.5 13092.3 13456.0 13456.4 14939.9 15379.2 3678.7 4439.4 4499.3 4626.7 5060.8 3449.3 3553.1 5013.0 5159.8 5321.2 5246.6 5278.3 5285.7 5299.5 5303.1 5155.3 5248.8 5263.4 5287.6 5298.9 5177.0 5198.6 5199.0 5201.6 5204.4 11485.5 11908.2 11908.5 11927.3 11927.9 1737.1 1789.1 1854.2 1869.9 1974.1 8685.6 8792.0 8843.4 8968.3 9148.3 1729.3 1736.1 1743.5 1754.9 1768.4 53718.7 55138.4 55509.4 55792.4 56495.2 9751.9 9762.5 9806.2 9814.0 9831.7 12506.2 12520.2 12528.5 12537.1 12548.4 6711.5 6898.9 6997.2 7050.4 7136.7 6890.8 6894.7 6898.4 6953.9 6969.3 4138.5 4146.9 4177.5 4183.4 4205.3 1638.9 1673.3 1676.6 1678.7 1701.7 684.6 864.6 867.8 925.6 935.5 15502.9 15668.2 15856.6 16245.2 16276.4 733.1 749.3 792.0 926.1 960.0 7695.0 8489.6 8932.8 9440.9 9449.5 510771.0 511475.0 519981.0 524030.0 525532.0 67119.3 70879.6 71755.6 72583.0 73930.6 1076.3 1076.6 1084.4 1087.4 1093.1 14708.3 14798.3 14976.9 15017.2 15285.2 33459.2 33579.7 33820.8 33850.2 33992.8 45253.0 46626.8 47052.3 47093.3 47369.0 8936.6 9142.5 9208.1 9208.4 9210.7 10578.2 12001.5 16522.9 16551.6 16648.8 12811.8 13060.0 13101.7 13161.5 13588.7 12628.0 12993.3 13121.5 13623.6 13727.5 13218.8 13400.5 13637.0 13864.4 14138.8 6812.8 8753.6 8843.2 8856.9 8874.8 12599.5 12800.5 12906.2 13006.6 13203.7 09:34:17 INFO - 2015-12-18 09:34:17,834 DEBUG : BROWSER_OUTPUT: 09:34:17 INFO - 2015-12-18 09:34:17,834 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5007.81 Median:6249.80 stddev:2644.81 (42.3%) stddev-sans-first:2638.94 09:34:17 INFO - 2015-12-18 09:34:17,835 DEBUG : BROWSER_OUTPUT: Values: 1480.1 1609.1 1688.4 1693.3 1735.7 6879.4 7328.7 7347.5 7355.1 7357.8 7223.7 7277.3 7288.4 7298.6 7301.9 2035.8 2064.2 2066.2 2066.9 2067.0 2072.1 2138.3 2138.9 2139.5 2140.2 1753.1 1788.6 1791.9 2060.1 2094.2 1774.4 1781.6 1978.2 2023.6 2026.7 2054.7 2062.8 2074.9 2076.5 2077.3 5891.6 7221.6 7294.0 7299.8 7303.2 3664.2 4039.7 4107.5 4116.4 4124.8 2666.8 2671.2 2682.3 2726.9 2728.6 866.4 868.7 878.5 885.9 886.6 9724.0 9792.2 9818.8 9826.0 9842.5 3885.9 3930.0 3961.2 3978.7 4018.0 8530.7 8537.4 8550.9 8565.5 8576.7 4365.8 4367.5 4371.4 4374.1 4377.6 3958.6 3963.4 3963.5 3966.9 3969.1 3371.2 3380.7 3390.8 3392.6 3410.7 1071.1 1074.3 1090.9 1098.3 1104.3 1002.2 1014.4 1046.4 1058.7 1060.3 6671.0 6744.9 6770.4 6771.0 6774.8 412.6 413.5 419.2 419.9 422.1 4741.4 5295.4 5360.4 5365.7 5366.2 7720.5 8530.3 8541.6 8637.0 8666.9 8341.7 8392.6 8405.0 8434.1 8469.4 6712.5 6833.4 6844.6 6846.7 6873.5 6725.3 6759.8 6775.1 6796.0 6810.4 7581.7 7765.2 7851.7 7864.2 7868.5 7899.4 7906.8 8019.8 8028.5 8038.0 5768.2 6273.4 6286.1 6293.1 6306.1 6649.8 6656.3 6658.8 6674.8 6701.2 6495.4 6590.6 6603.1 6668.8 6705.5 6353.5 6359.6 6378.5 6435.5 6562.8 6594.7 6602.6 6626.6 6633.6 6633.7 5781.1 5921.2 6039.2 6091.4 6096.3 6202.8 6215.3 6236.6 6248.7 6250.9 09:34:17 INFO - 2015-12-18 09:34:17,835 DEBUG : BROWSER_OUTPUT: 09:34:17 INFO - 2015-12-18 09:34:17,835 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4658.83 Median:5323.35 stddev:1384.31 (26.0%) stddev-sans-first:1348.99 09:34:17 INFO - 2015-12-18 09:34:17,835 DEBUG : BROWSER_OUTPUT: Values: 300.3 302.1 306.1 310.1 310.9 5298.9 5307.0 5312.9 5409.9 5417.7 5247.9 5289.7 5318.8 5327.9 5329.2 4180.6 4186.3 4187.8 4188.4 4191.9 4192.2 4192.7 4198.0 4202.9 4204.8 3947.0 4014.5 4028.5 4123.2 4136.3 4029.7 4044.6 4046.9 4080.4 4083.4 3528.3 3529.4 3538.3 3539.2 3542.6 5163.4 5172.8 5180.5 5181.8 5182.6 4541.2 4674.3 4681.5 4687.4 4689.4 5578.3 5595.9 5596.9 5597.1 5598.8 3798.1 3830.2 3834.2 3836.5 3837.2 5638.4 5698.0 5785.6 5787.2 5887.8 3967.6 3991.4 3993.0 3998.4 4013.8 4024.8 4041.6 4047.7 4050.2 4052.3 4398.3 4552.2 4559.0 4640.3 4661.2 5608.6 5613.6 5614.6 5620.5 5630.6 1403.2 1433.7 1435.4 1435.6 1435.8 950.9 956.1 958.9 974.8 977.8 4934.0 4945.3 4949.0 4952.1 4952.3 5846.6 5847.2 5848.2 5849.6 5854.0 4895.6 4932.4 4933.9 4935.9 4944.4 3068.4 3110.8 3140.6 3146.9 3157.4 5505.7 5551.1 5562.2 5564.2 5568.8 6052.7 6056.1 6064.5 6066.5 6067.8 5559.9 5560.1 5565.9 5569.1 5570.5 5709.9 5844.0 5888.3 5905.4 5911.9 5682.3 5699.4 5717.7 5727.6 5746.3 5542.0 5545.5 5547.9 5551.0 5551.3 3885.4 3961.4 4024.3 4025.6 4036.9 5669.5 5820.8 5836.5 5841.6 5841.8 5546.6 5671.5 5691.6 5700.0 5710.8 5649.2 5683.5 5684.2 5685.8 5692.5 5431.9 5555.6 5559.2 5569.7 5577.2 5682.5 5718.1 5727.3 5730.7 5734.9 5567.1 5584.2 5586.0 5587.8 5594.1 09:34:17 INFO - 2015-12-18 09:34:17,835 DEBUG : BROWSER_OUTPUT: 09:34:17 INFO - 2015-12-18 09:34:17,835 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11862.58 Median:22587.93 stddev:13308.86 (58.9%) stddev-sans-first:13319.75 09:34:17 INFO - 2015-12-18 09:34:17,835 DEBUG : BROWSER_OUTPUT: Values: 690.8 758.5 798.2 810.2 824.0 11010.8 11117.3 11161.9 11181.0 11203.9 11578.2 11716.8 11763.2 11819.9 11845.5 750.5 778.8 785.6 785.8 787.9 762.2 782.2 789.2 790.5 790.6 782.7 806.1 812.9 813.5 813.7 784.6 800.6 800.9 806.5 806.7 582.3 586.9 599.9 599.9 600.0 9831.3 9996.7 10082.6 10242.5 11085.3 10821.7 11034.8 11091.9 11274.7 11431.8 8791.7 9072.6 9171.1 9397.5 9399.3 3184.2 3238.5 3239.7 3258.2 3319.4 36656.5 37025.4 37031.1 37055.3 37116.6 8797.7 9155.8 9168.3 9195.4 9521.2 15572.4 15663.3 15672.1 15686.1 15718.2 6192.8 6387.3 6501.9 6512.1 6691.8 3569.6 3677.8 3691.5 3699.0 3704.3 2547.6 2551.5 2552.4 2560.3 2564.1 459.7 469.9 474.3 478.1 481.0 499.7 500.1 523.5 564.7 608.3 7306.6 7699.4 7826.2 7868.6 7895.6 399.9 447.9 537.8 584.0 604.7 3567.7 3651.2 3697.4 3706.4 3802.4 47138.5 48405.3 48419.8 48473.3 48477.3 43581.3 43649.1 44463.3 44728.0 44953.6 39688.8 39898.8 40137.0 40560.2 40879.4 7129.7 7212.4 7287.6 7331.7 7451.8 29591.0 29636.6 29853.7 30087.2 30209.7 35724.3 35889.6 37610.4 39252.6 39274.0 10024.7 10083.2 10178.5 10344.8 10363.4 11208.7 11233.7 11270.2 11943.4 12108.9 10012.7 10232.6 10395.6 10574.3 11026.2 9798.9 9897.9 10223.8 10251.5 10599.8 10447.5 10597.7 10662.3 10671.1 10855.7 8797.5 8941.1 8965.3 9151.6 9251.4 8594.7 9019.0 9026.6 9148.1 9224.4 09:34:17 INFO - 2015-12-18 09:34:17,835 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:34:17 INFO - 2015-12-18 09:34:17,835 DEBUG : BROWSER_OUTPUT: 09:34:18 INFO - 2015-12-18 09:34:18,539 INFO : Browser exited with error code: 0 09:34:18 INFO - 2015-12-18 09:34:18,560 INFO : Completed test dromaeo_css (00:18:38) 09:34:18 INFO - 2015-12-18 09:34:18,560 INFO : Starting test kraken 09:34:18 INFO - 2015-12-18 09:34:18,560 DEBUG : operating with platform_type : linux_ 09:34:18 INFO - 2015-12-18 09:34:18,560 INFO : Initialising browser for kraken test... 09:34:18 INFO - 2015-12-18 09:34:18,567 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWBalnR/profile http://localhost:33004/getInfo.html 09:34:23 INFO - 2015-12-18 09:34:23,011 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:34:23 INFO - 2015-12-18 09:34:23,011 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:34:23 INFO - 2015-12-18 09:34:23,012 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:34:23 INFO - 2015-12-18 09:34:23,012 DEBUG : BROWSER_OUTPUT: __metrics 09:34:23 INFO - 2015-12-18 09:34:23,148 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:34:23 INFO - 2015-12-18 09:34:23,209 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:24 INFO - 2015-12-18 09:34:24,537 INFO : Browser initialized. 09:34:24 INFO - 2015-12-18 09:34:24,538 INFO : Running cycle 1/1 for kraken test... 09:34:24 INFO - 2015-12-18 09:34:24,538 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWBalnR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:34:36 INFO - 2015-12-18 09:34:36,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 150065152 09:34:36 INFO - 2015-12-18 09:34:36,537 DEBUG : BROWSER_OUTPUT: 09:34:39 INFO - 2015-12-18 09:34:39,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33004/tests/kraken/driver.html?testName=audio-beat-detection) 09:34:39 INFO - 2015-12-18 09:34:39,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 183517184 09:34:39 INFO - 2015-12-18 09:34:39,721 DEBUG : BROWSER_OUTPUT: 09:34:42 INFO - 2015-12-18 09:34:42,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33004/tests/kraken/driver.html?testName=audio-dft) 09:34:43 INFO - 2015-12-18 09:34:43,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 175075328 09:34:43 INFO - 2015-12-18 09:34:43,011 DEBUG : BROWSER_OUTPUT: 09:34:45 INFO - 2015-12-18 09:34:45,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33004/tests/kraken/driver.html?testName=audio-fft) 09:34:46 INFO - 2015-12-18 09:34:46,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 160280576 09:34:46 INFO - 2015-12-18 09:34:46,557 DEBUG : BROWSER_OUTPUT: 09:34:48 INFO - 2015-12-18 09:34:48,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33004/tests/kraken/driver.html?testName=audio-oscillator) 09:34:49 INFO - 2015-12-18 09:34:49,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 163012608 09:34:49 INFO - 2015-12-18 09:34:49,214 DEBUG : BROWSER_OUTPUT: 09:34:51 INFO - 2015-12-18 09:34:51,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33004/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:34:52 INFO - 2015-12-18 09:34:52,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 163889152 09:34:52 INFO - 2015-12-18 09:34:52,035 DEBUG : BROWSER_OUTPUT: 09:34:54 INFO - 2015-12-18 09:34:54,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33004/tests/kraken/driver.html?testName=imaging-darkroom) 09:34:55 INFO - 2015-12-18 09:34:55,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 164659200 09:34:55 INFO - 2015-12-18 09:34:55,561 DEBUG : BROWSER_OUTPUT: 09:34:58 INFO - 2015-12-18 09:34:58,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33004/tests/kraken/driver.html?testName=imaging-desaturate) 09:34:59 INFO - 2015-12-18 09:34:59,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 166363136 09:34:59 INFO - 2015-12-18 09:34:59,517 DEBUG : BROWSER_OUTPUT: 09:35:02 INFO - 2015-12-18 09:35:02,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33004/tests/kraken/driver.html?testName=json-parse-financial) 09:35:02 INFO - 2015-12-18 09:35:02,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 165265408 09:35:02 INFO - 2015-12-18 09:35:02,968 DEBUG : BROWSER_OUTPUT: 09:35:04 INFO - 2015-12-18 09:35:04,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33004/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:05 INFO - 2015-12-18 09:35:05,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 173694976 09:35:05 INFO - 2015-12-18 09:35:05,339 DEBUG : BROWSER_OUTPUT: 09:35:07 INFO - 2015-12-18 09:35:07,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33004/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:07 INFO - 2015-12-18 09:35:07,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 173158400 09:35:07 INFO - 2015-12-18 09:35:07,799 DEBUG : BROWSER_OUTPUT: 09:35:09 INFO - 2015-12-18 09:35:09,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33004/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:10 INFO - 2015-12-18 09:35:10,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 185012224 09:35:10 INFO - 2015-12-18 09:35:10,485 DEBUG : BROWSER_OUTPUT: 09:35:13 INFO - 2015-12-18 09:35:13,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:13 INFO - 2015-12-18 09:35:13,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 188551168 09:35:13 INFO - 2015-12-18 09:35:13,586 DEBUG : BROWSER_OUTPUT: 09:35:16 INFO - 2015-12-18 09:35:16,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:16 INFO - 2015-12-18 09:35:16,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 186232832 09:35:16 INFO - 2015-12-18 09:35:16,754 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33004/tests/kraken/driver.html?testName=ai-astar) 09:35:18 INFO - 2015-12-18 09:35:18,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 245063680 09:35:18 INFO - 2015-12-18 09:35:18,754 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,757 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:35:18 INFO - 2015-12-18 09:35:18,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:35:18 INFO - 2015-12-18 09:35:18,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:35:18 INFO - 2015-12-18 09:35:18,758 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:35:18 INFO - 2015-12-18 09:35:18,758 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;106;112;112;114;102;113;113;103 09:35:18 INFO - 2015-12-18 09:35:18,758 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;130;157;162;135;152;148;138;169;130 09:35:18 INFO - 2015-12-18 09:35:18,758 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;161;164;163;163;166;161;162 09:35:18 INFO - 2015-12-18 09:35:18,758 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;73;85;109;73;71;72;89;98;74 09:35:18 INFO - 2015-12-18 09:35:18,758 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;130;94;94;94;137;94;95;131 09:35:18 INFO - 2015-12-18 09:35:18,758 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;110;109;109;109 09:35:18 INFO - 2015-12-18 09:35:18,759 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;146;146;146;146;148;146;148 09:35:18 INFO - 2015-12-18 09:35:18,759 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;95;95;96;95;96;97;96;98;96 09:35:18 INFO - 2015-12-18 09:35:18,759 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;73;71;72;72;72;81;70;71 09:35:18 INFO - 2015-12-18 09:35:18,759 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;66;67;68;68;68;68;68;69 09:35:18 INFO - 2015-12-18 09:35:18,759 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;85;85;85;85;84;83;85;84 09:35:18 INFO - 2015-12-18 09:35:18,759 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;118;120;118;120;127;123;135;116;126 09:35:18 INFO - 2015-12-18 09:35:18,759 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;137;147;146;149;138;157;148;145;134 09:35:18 INFO - 2015-12-18 09:35:18,760 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;70;69;72;70;69;69;69;70 09:35:18 INFO - 2015-12-18 09:35:18,760 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:35:18 INFO - 2015-12-18 09:35:18,760 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:35:18 INFO - 2015-12-18 09:35:18,760 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 09:35:18 INFO - 2015-12-18 09:35:18,760 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:35:18 INFO - 2015-12-18 09:35:18,760 DEBUG : BROWSER_OUTPUT: __startTimestamp1450460118755__endTimestamp 09:35:18 INFO - 2015-12-18 09:35:18,760 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,768 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:35:18 INFO - 2015-12-18 09:35:18,768 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:35:18 INFO - 2015-12-18 09:35:18,768 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,768 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.80 Median:112.00 stddev:4.42 (3.9%) stddev-sans-first:4.66 09:35:18 INFO - 2015-12-18 09:35:18,768 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 106.0 112.0 112.0 114.0 102.0 113.0 113.0 103.0 09:35:18 INFO - 2015-12-18 09:35:18,768 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,768 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.10 Median:154.50 stddev:14.12 (9.1%) stddev-sans-first:14.31 09:35:18 INFO - 2015-12-18 09:35:18,768 DEBUG : BROWSER_OUTPUT: Values: 160.0 130.0 157.0 162.0 135.0 152.0 148.0 138.0 169.0 130.0 09:35:18 INFO - 2015-12-18 09:35:18,768 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.81 (1.1%) stddev-sans-first:1.87 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 161.0 164.0 163.0 163.0 166.0 161.0 162.0 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:12.93 (17.0%) stddev-sans-first:13.63 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: Values: 78.0 73.0 85.0 109.0 73.0 71.0 72.0 89.0 98.0 74.0 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:18.57 (19.8%) stddev-sans-first:19.35 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 130.0 94.0 94.0 94.0 137.0 94.0 95.0 131.0 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 148.0 146.0 148.0 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,769 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.58 (1.6%) stddev-sans-first:1.00 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: Values: 100.0 95.0 95.0 96.0 95.0 96.0 97.0 96.0 98.0 96.0 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.70 Median:72.00 stddev:3.06 (4.2%) stddev-sans-first:3.24 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 71.0 72.0 72.0 72.0 81.0 70.0 71.0 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 67.0 68.0 68.0 68.0 68.0 68.0 69.0 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:0.97 (1.1%) stddev-sans-first:0.87 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 85.0 85.0 85.0 85.0 84.0 83.0 85.0 84.0 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:121.50 stddev:5.89 (4.8%) stddev-sans-first:5.96 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: Values: 117.0 118.0 120.0 118.0 120.0 127.0 123.0 135.0 116.0 126.0 09:35:18 INFO - 2015-12-18 09:35:18,770 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,771 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:146.50 stddev:6.87 (4.7%) stddev-sans-first:7.13 09:35:18 INFO - 2015-12-18 09:35:18,771 DEBUG : BROWSER_OUTPUT: Values: 140.0 137.0 147.0 146.0 149.0 138.0 157.0 148.0 145.0 134.0 09:35:18 INFO - 2015-12-18 09:35:18,771 DEBUG : BROWSER_OUTPUT: 09:35:18 INFO - 2015-12-18 09:35:18,771 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:0.99 (1.4%) stddev-sans-first:1.05 09:35:18 INFO - 2015-12-18 09:35:18,771 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 70.0 69.0 72.0 70.0 69.0 69.0 69.0 70.0 09:35:18 INFO - 2015-12-18 09:35:18,771 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:35:18 INFO - 2015-12-18 09:35:18,771 DEBUG : BROWSER_OUTPUT: 09:35:19 INFO - 2015-12-18 09:35:19,767 INFO : Browser exited with error code: 0 09:35:19 INFO - 2015-12-18 09:35:19,816 INFO : Completed test kraken (00:01:01) 09:35:19 INFO - 2015-12-18 09:35:19,816 INFO : Starting test v8_7 09:35:19 INFO - 2015-12-18 09:35:19,816 DEBUG : operating with platform_type : linux_ 09:35:19 INFO - 2015-12-18 09:35:19,816 INFO : Initialising browser for v8_7 test... 09:35:19 INFO - 2015-12-18 09:35:19,823 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpheOSYj/profile http://localhost:33004/getInfo.html 09:35:24 INFO - 2015-12-18 09:35:24,555 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:35:24 INFO - 2015-12-18 09:35:24,555 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:35:24 INFO - 2015-12-18 09:35:24,556 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:35:24 INFO - 2015-12-18 09:35:24,556 DEBUG : BROWSER_OUTPUT: __metrics 09:35:24 INFO - 2015-12-18 09:35:24,753 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:35:24 INFO - 2015-12-18 09:35:24,829 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:35:26 INFO - 2015-12-18 09:35:26,192 INFO : Browser initialized. 09:35:26 INFO - 2015-12-18 09:35:26,192 INFO : Running cycle 1/1 for v8_7 test... 09:35:26 INFO - 2015-12-18 09:35:26,192 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpheOSYj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:35:38 INFO - 2015-12-18 09:35:38,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 150073344 09:35:38 INFO - 2015-12-18 09:35:38,165 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33004/tests/v8_7/run.html (next: http://localhost:33004/tests/v8_7/run.html) 09:35:59 INFO - 2015-12-18 09:35:59,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 445362176 09:35:59 INFO - 2015-12-18 09:35:59,837 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,838 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:35:59 INFO - 2015-12-18 09:35:59,838 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:35:59 INFO - 2015-12-18 09:35:59,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:35:59 INFO - 2015-12-18 09:35:59,839 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:35:59 INFO - 2015-12-18 09:35:59,839 DEBUG : BROWSER_OUTPUT: |0;Richards;165.23463317911435 09:35:59 INFO - 2015-12-18 09:35:59,839 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.64833462432222 09:35:59 INFO - 2015-12-18 09:35:59,839 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 09:35:59 INFO - 2015-12-18 09:35:59,840 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5180.412371134021 09:35:59 INFO - 2015-12-18 09:35:59,840 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1970.4724409448818 09:35:59 INFO - 2015-12-18 09:35:59,840 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 09:35:59 INFO - 2015-12-18 09:35:59,840 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 09:35:59 INFO - 2015-12-18 09:35:59,840 DEBUG : BROWSER_OUTPUT: |7;RegExp;27486.486486486487 09:35:59 INFO - 2015-12-18 09:35:59,841 DEBUG : BROWSER_OUTPUT: |8;Splay;610.6408706166868 09:35:59 INFO - 2015-12-18 09:35:59,841 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 09:35:59 INFO - 2015-12-18 09:35:59,841 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:35:59 INFO - 2015-12-18 09:35:59,841 DEBUG : BROWSER_OUTPUT: __startTimestamp1450460159837__endTimestamp 09:35:59 INFO - 2015-12-18 09:35:59,842 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,843 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:35:59 INFO - 2015-12-18 09:35:59,843 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:35:59 INFO - 2015-12-18 09:35:59,843 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,843 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.23 Median:165.23 stddev:0.00 (0.0%) 09:35:59 INFO - 2015-12-18 09:35:59,843 DEBUG : BROWSER_OUTPUT: Values: 165.2 09:35:59 INFO - 2015-12-18 09:35:59,843 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,843 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.65 Median:193.65 stddev:0.00 (0.0%) 09:35:59 INFO - 2015-12-18 09:35:59,843 DEBUG : BROWSER_OUTPUT: Values: 193.6 09:35:59 INFO - 2015-12-18 09:35:59,844 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,844 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 09:35:59 INFO - 2015-12-18 09:35:59,844 DEBUG : BROWSER_OUTPUT: Values: 278.6 09:35:59 INFO - 2015-12-18 09:35:59,844 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,844 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5180.41 Median:5180.41 stddev:0.00 (0.0%) 09:35:59 INFO - 2015-12-18 09:35:59,844 DEBUG : BROWSER_OUTPUT: Values: 5180.4 09:35:59 INFO - 2015-12-18 09:35:59,844 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,844 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 09:35:59 INFO - 2015-12-18 09:35:59,844 DEBUG : BROWSER_OUTPUT: Values: 1970.5 09:35:59 INFO - 2015-12-18 09:35:59,844 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: Values: 794.3 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: Values: 12048.2 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27486.49 Median:27486.49 stddev:0.00 (0.0%) 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: Values: 27486.5 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.64 Median:610.64 stddev:0.00 (0.0%) 09:35:59 INFO - 2015-12-18 09:35:59,845 DEBUG : BROWSER_OUTPUT: Values: 610.6 09:35:59 INFO - 2015-12-18 09:35:59,846 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-12-18 09:35:59,846 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 09:35:59 INFO - 2015-12-18 09:35:59,846 DEBUG : BROWSER_OUTPUT: Values: 4840.6 09:35:59 INFO - 2015-12-18 09:35:59,846 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:35:59 INFO - 2015-12-18 09:35:59,846 DEBUG : BROWSER_OUTPUT: 09:36:00 INFO - 2015-12-18 09:36:00,739 INFO : Browser exited with error code: 0 09:36:00 INFO - 2015-12-18 09:36:00,756 INFO : Completed test v8_7 (00:00:40) 09:36:00 INFO - 2015-12-18 09:36:00,859 INFO : Completed test suite (00:20:20) 09:36:00 INFO - 2015-12-18 09:36:00,859 DEBUG : Working with test: dromaeo_css 09:36:00 INFO - 2015-12-18 09:36:00,859 DEBUG : Generating results file: dromaeo_css 09:36:00 INFO - 2015-12-18 09:36:00,860 DEBUG : Working with test: kraken 09:36:00 INFO - 2015-12-18 09:36:00,860 DEBUG : Generating results file: kraken 09:36:00 INFO - 2015-12-18 09:36:00,861 INFO : javascript benchmark 09:36:00 INFO - 2015-12-18 09:36:00,861 DEBUG : Working with test: v8_7 09:36:00 INFO - 2015-12-18 09:36:00,861 DEBUG : Generating results file: v8_7 09:36:00 INFO - 2015-12-18 09:36:00,862 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:36:00 INFO - 2015-12-18 09:36:00,921 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:36:00 INFO - 2015-12-18 09:36:00,921 DEBUG : process_Request line: dromaeo_css 6211.42 graph.html#tests=[[72,132,35]] 09:36:00 INFO - 2015-12-18 09:36:00,921 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:36:00 INFO - 2015-12-18 09:36:00,954 DEBUG : process_Request line: kraken 1521.00 graph.html#tests=[[232,132,35]] 09:36:00 INFO - 2015-12-18 09:36:00,954 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:36:00 INFO - 2015-12-18 09:36:00,994 DEBUG : process_Request line: v8_7 19700.10 graph.html#tests=[[230,132,35]] 09:36:00 INFO - 2015-12-18 09:36:00,996 INFO : javascript benchmark 09:36:01 INFO - 2015-12-18 09:36:00,999 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2619.751123643254, 2696.23157400141, 2711.362829735012, 2714.158610830643, 2727.1000569811963, 4427.77861106945, 4599.88500287493, 4647.3029045643125, 4719.103370359633, 4729.077829823186, 4626.514216007321, 4708.7645617719145, 4708.835190768324, 4745.549172828584, 4906.190478571031, 4340.761258130801, 4349.934750978738, 4357.237483440385, 4357.43353364063, 4432.047109871377, 4150.211459822624, 4494.438195225597, 4515.300128480075, 4536.931946020813, 4551.0, 4283.3146696528565, 4297.247981603207, 4374.081442896995, 4394.60448559628, 4416.779161041935, 4320.870373888788, 4320.978395108035, 4343.2182207202695, 4370.082282720632, 4380.255356589356, 4299.419578356944, 4310.3103503439615, 4314.0, 4360.585744354281, 4362.36745671879, 4452.532484089189, 4579.267317229227, 4586.472555656109, 4654.953450465486, 4750.097481478542, 5034.14419548674, 5034.395872495287, 5035.748212589392, 5045.823396181116, 5080.13637681595, 5033.924491132636, 5042.873928151826, 5063.139266324733, 5065.620078494091, 5081.66969147008, 4507.774611269423, 4607.032523170172, 4608.815647374101, 4712.976435117871, 4842.539958703917, 5237.397699264558, 5260.026895024433, 5261.842144735664, 5265.7103859287345, 5266.973665131726, 5039.042581909499, 5046.318746969186, 5051.974740126276, 5052.9242061369105, 5077.416097148801, 4881.95118048822, 4928.67963582366, 4993.80024799004, 4995.275685025651, 5017.222330538772, 5066.46802085783, 5075.695458272516, 5079.288899554065, 5081.74591270435, 5131.384233891882, 5059.06407314648, 5061.089003979319, 5062.215356619729, 5064.1897296433135, 5069.340985671839, 4010.0776821331256, 4071.5521292657786, 4115.259253334369, 4117.608827161415, 4222.577742225814, 3746.1758413149064, 3750.83121259544, 3759.266942946154, 3776.0937375029794, 3813.5423749149722, 4400.713953593006, 4406.889827754268, 4419.734815911055, 4421.668374871898, 4461.866144015685, 4881.633877459205, 4999.65002449825, 5008.0, 5177.8187763428095, 5200.089984252816, 4322.832835134496, 4374.4531933508315, 4385.144896745168, 4426.557344265548, 4433.046894917544, 4479.238529450001, 4540.659450541157, 4588.128255631419, 4602.309653551927, 4640.814367425332, 4606.88482787933, 4716.221823399101, 4721.4570324413135, 4850.029994001214, 4859.781309841136, 5084.440711521804, 5129.204973229155, 5144.228365745168, 5148.97425512885, 5193.68837869729, 4764.49972752856, 4807.6394270429155, 4808.966072294474, 4812.398450193726, 4852.102361063215, 4758.714477131383, 4844.636652251025, 4855.6115510758345, 5022.422421421583, 5079.3650793650795, 4964.205727083649, 5035.420926593342, 5073.137566613611, 5078.695278283167, 5120.001599688025, 4936.259561065725, 4950.282209079592, 4950.975245123751, 4956.727379994135, 4998.525140111684, 4772.284157376422, 4893.853184404474, 4908.803647854189, 4945.851624451272, 4996.475370086088, 4697.530246975275, 4789.042191561632, 4873.878153046202, 4883.975580122076, 4896.387951506062, 4931.7040977541465, 4959.504049595012, 4963.851084467472, 4967.111146439936, 5008.0, 4643.86068417948, 4783.6651434399255, 4849.9815038842235, 4866.221404575251, 4872.9512704872495], "unit": "score", "name": "dojo.html", "value": 4640.143297373756}, {"lowerIsBetter": false, "replicates": [564.258000729041, 569.4305694305694, 569.444791328455, 571.851318657149, 573.8450618333051, 26274.2117736468, 35201.64798352015, 35398.823005884966, 35477.82261088691, 35503.64496355036, 39717.205655886864, 39955.800220998855, 40047.799761001224, 40198.0, 40314.39528407069, 6855.828604284883, 6933.1333583302085, 7674.846503069935, 7826.178251283619, 7827.7260295889655, 9989.600415983388, 10207.234457415687, 10211.642592509264, 10211.744706382362, 10215.795684086313, 9650.469224192666, 9795.510224488782, 9795.657151999681, 9801.950990245039, 9803.0, 7117.679704413288, 7256.310650488195, 9637.759056023586, 10051.648192313234, 10284.43435611041, 9686.564104615309, 9834.754131146707, 9841.114299712988, 9845.606175753033, 9849.458279794608, 29597.0, 36607.63392366069, 37113.0, 37138.814305928296, 37152.0, 2336.2874323331375, 2916.066858605247, 2920.7225313595172, 2960.866760995739, 2994.6107006089287, 26216.73783262162, 26488.60267095995, 26580.0, 26627.600585991226, 27137.864310678517, 3281.3273278977754, 3298.422776014212, 3322.933541329184, 3374.5950485941844, 3382.374260761767, 173452.0, 173715.0, 175075.0, 175135.0, 175365.0, 47698.28452573214, 48211.491448654684, 48986.75506622444, 49746.0, 52168.43557684115, 46200.537994620296, 46359.768201158775, 46375.53624463712, 46375.5362446378, 46740.29889551659, 13261.93369033168, 13388.665283367995, 13448.596542103556, 13456.663583410298, 13462.932685336511, 10724.356538607552, 10798.352098874093, 10816.134709223243, 10828.404437755842, 10830.566777328977, 17543.0, 17630.647387052188, 17669.38157164493, 17812.287508499776, 17871.463856084338, 6946.0, 7185.784426467214, 7209.279072092749, 7224.819379515449, 7290.744823931137, 869.2394155114275, 876.5660997806127, 910.9074691422584, 992.389680346596, 997.4613708597421, 25621.48757024849, 26501.867490662422, 26532.204033879014, 26917.327066823094, 27219.319517012234, 917.8026724254318, 954.5752140297501, 958.1759686669459, 966.8549717542425, 982.4007355513131, 12106.455209515592, 12165.817512737316, 12316.322602256783, 12388.442520086617, 12458.190217635825, 266154.0, 268351.0, 270154.0, 270312.0, 270788.0, 43724.78137609355, 43829.78085109618, 43914.0, 44046.559534404885, 44053.33919991203, 1215.7872372334982, 1219.5792451604004, 1223.1865809236758, 1227.7298994221258, 1232.1559731583893, 23195.6520652187, 23221.41946451352, 26008.21975340743, 26826.731732682423, 28329.291767705974, 38140.809295953346, 38547.0, 38567.42148867713, 38593.614063859, 38680.0, 198644.0, 199644.0, 199841.0, 199921.0, 200355.0, 23869.283921482383, 24588.631170532815, 24591.38521536976, 25625.39018830672, 27740.445191096467, 28886.0, 29162.708372916848, 30771.846140769154, 34025.319493610485, 34805.825970869984, 28733.856330718212, 29460.705392945798, 30606.846965765028, 30896.69103309028, 30937.69062309348, 30414.239644009078, 30662.693373066875, 30742.53886191664, 30752.384952301276, 30787.0, 30306.090817275515, 31409.842950786013, 31457.528137077505, 31496.0, 31625.525617116222, 26135.869320653273, 28113.859430702716, 28237.717622823508, 28247.717522824507, 28268.0, 21540.246091386725, 22136.557268854856, 22148.77851221467, 22171.55656886821, 22212.88893555522], "unit": "score", "name": "ext.html", "value": 16232.564719927474}, {"lowerIsBetter": false, "replicates": [316.68331668331666, 321.7040322902929, 327.3714468221015, 331.62691971532035, 334.1262598305431, 12409.131360804748, 12745.872541274608, 14680.77978830317, 15185.620359491018, 15852.524424267276, 13092.34538273085, 13456.0, 13456.394462249198, 14939.92530037351, 15379.154146521936, 3678.7057035437233, 4439.356293337481, 4499.325101234825, 4626.65300102492, 5060.79756809729, 3449.3273811606746, 3553.1472446612756, 5013.047520971022, 5159.819406320779, 5321.201819727053, 5246.580273578104, 5278.261043453919, 5285.656432331905, 5299.54953828925, 5303.124984377573, 5155.252488389181, 5248.81629142982, 5263.394709608387, 5287.629865909388, 5298.92051619226, 5177.042247184283, 5198.636095473318, 5198.974005129988, 5201.557867581222, 5204.401493828221, 11485.483153258123, 11908.225965312227, 11908.523659053628, 11927.343996080212, 11927.940360298144, 1737.0533059482611, 1789.1412122181296, 1854.1934258597553, 1869.9439016829517, 1974.0721860725437, 8685.609147588311, 8792.0, 8843.425177363451, 8968.327375446868, 9148.313876459291, 1729.2564197395116, 1736.1145815634118, 1743.5205318537378, 1754.9473515794546, 1768.3633891798943, 53718.73140634272, 55138.448615513735, 55509.44490555083, 55792.442075579536, 56495.15257271144, 9751.902480975099, 9762.511874406393, 9806.166475849634, 9813.950930245303, 9831.655892043887, 12506.187097838794, 12520.248785072925, 12528.498860045678, 12537.122401431994, 12548.435320410603, 6711.496637752188, 6898.896516552256, 6997.160340759141, 7050.365467107985, 7136.7145314186855, 6890.758823441155, 6894.689738961759, 6898.379145876896, 6953.860922781617, 6969.30306969299, 4138.482689663792, 4146.937795933063, 4177.4778152730905, 4183.3515805050265, 4205.3481710334945, 1638.860696840758, 1673.2972151696317, 1676.5640933357415, 1678.7481877718196, 1701.6936951348628, 684.6234570985938, 864.6498168241872, 867.8481265778463, 925.6204955968021, 935.5275585829113, 15502.9224853875, 15668.216589170495, 15856.60358491047, 16245.187740612922, 16276.43032493857, 733.0690023670016, 749.3218637133403, 792.0455850699893, 926.0970553710214, 959.9712008639752, 7694.961525192338, 8489.61796719149, 8932.821343573092, 9440.858387124199, 9449.480278584606, 510771.0, 511475.0, 519981.0, 524030.0, 525532.0, 67119.32880671228, 70879.64560177166, 71755.6412217946, 72583.0, 73930.63034684792, 1076.3488089705772, 1076.6285631457135, 1084.436093231531, 1087.3584585094675, 1093.0981939899614, 14708.264586770832, 14798.334074966437, 14976.92511537479, 15017.17405542662, 15285.159316237714, 33459.163520912174, 33579.66420335863, 33820.830895846346, 33850.153746156546, 33992.83003584966, 45253.0, 46626.76686616545, 47052.29421558748, 47093.293600596706, 47369.0, 8936.553172341486, 9142.451452912846, 9208.079192080739, 9208.401453905475, 9210.723678289662, 10578.206634502289, 12001.459934303151, 16522.926009809325, 16551.586210344358, 16648.83351166473, 12811.80782288285, 13060.0, 13101.672458188621, 13161.53934612284, 13588.660283492596, 12628.0, 12993.285369304778, 13121.524390545892, 13623.591292261248, 13727.519536816164, 13218.801717974431, 13400.463981440633, 13637.0, 13864.445422183, 14138.78791818103, 6812.795616131524, 8753.64985400577, 8843.248323892542, 8856.911430885608, 8874.822503549763, 12599.496020159091, 12800.487980480677, 12906.161099528501, 13006.609801705965, 13203.66990825237], "unit": "score", "name": "jquery.html", "value": 8082.523970141894}, {"lowerIsBetter": false, "replicates": [1480.1415179196067, 1609.106945645167, 1688.4006177806878, 1693.280355848764, 1735.6962531556983, 6879.449644028478, 7328.743493977712, 7347.522411043292, 7355.117385913684, 7357.779266622003, 7223.747168849091, 7277.2722727727205, 7288.416926645868, 7298.598577078258, 7301.89047164293, 2035.8371330293614, 2064.153696984237, 2066.1941842681367, 2066.875987440751, 2067.0284966066, 2072.108993132952, 2138.3264271754347, 2138.9358319250446, 2139.475828422039, 2140.1867290429614, 1753.1059159828515, 1788.579683774312, 1791.8924864508106, 2060.052375907077, 2094.2460714142894, 1774.3612299572208, 1781.5813283878279, 1978.1988294740654, 2023.5952809438024, 2026.6959956006717, 2054.7431571053617, 2062.82465990391, 2074.8547601667888, 2076.480879780055, 2077.314486219544, 5891.558133139989, 7221.638918054076, 7293.963530182368, 7299.817504562376, 7303.2331605181225, 3664.193877346979, 4039.7172197946156, 4107.486564179478, 4116.382542618601, 4124.8143833527565, 2666.7999900007576, 2671.1719366996294, 2682.3026013236504, 2726.9228654681488, 2728.590711393287, 866.3588944181323, 868.7393781865416, 878.5036454403241, 885.9424137431047, 886.6453418632534, 9724.0, 9792.16766574842, 9818.75453113678, 9826.017398260188, 9842.50787460624, 3885.86399476017, 3929.9607003929596, 3961.187956468917, 3978.7214894957074, 4017.959820401817, 8530.74407767768, 8537.402381833337, 8550.914490855137, 8565.528895910784, 8576.656933722707, 4365.847195348148, 4367.497737760198, 4371.366151907955, 4374.147041326911, 4377.562243775597, 3958.6041395860184, 3963.4451176835264, 3963.4649322341115, 3966.9206615868097, 3969.146633473817, 3371.174062354739, 3380.695737383647, 3390.7626466147135, 3392.5589673342306, 3410.710089642408, 1071.1430855315716, 1074.3017038924604, 1090.8963648453384, 1098.2531878322818, 1104.309806371018, 1002.1932344462778, 1014.3862962907335, 1046.4140081554353, 1058.6718117383482, 1060.3213943076437, 6671.032700258435, 6744.898826517606, 6770.356816102462, 6770.966145169243, 6774.796756097325, 412.6368795460036, 413.5389041219019, 419.216065956663, 419.92651286024824, 422.0840775517135, 4741.359916411309, 5295.417504074549, 5360.356757189084, 5365.704886231295, 5366.195070739421, 7720.459567830198, 8530.274926631306, 8541.572921353907, 8636.956815215884, 8666.913330866737, 8341.66633334672, 8392.622331994953, 8404.957975210085, 8434.072252052269, 8469.3647976402, 6712.496562757715, 6833.384995350343, 6844.623545705034, 6846.691898864563, 6873.48448866327, 6725.327467253432, 6759.763408280686, 6775.085363476065, 6795.9806029096035, 6810.353016463428, 7581.658825352762, 7765.1846556110795, 7851.725189618336, 7864.21357864209, 7868.488548244346, 7899.368050555827, 7906.841863162819, 8019.799505012421, 8028.518288902685, 8037.959810200911, 5768.221290125779, 6273.435390814849, 6286.057091436322, 6293.118963345227, 6306.117143599808, 6649.800505984828, 6656.334366563305, 6658.83352916181, 6674.83312917181, 6701.229358623821, 6495.447886929475, 6590.571612845341, 6603.141591593062, 6668.766593169215, 6705.497087718538, 6353.4599559038, 6359.554831161774, 6378.45783108441, 6435.549511534147, 6562.80311590653, 6594.70323835419, 6602.60384376939, 6626.635535045619, 6633.6019838809825, 6633.734650613921, 5781.075027995501, 5921.200637913998, 6039.214902062704, 6091.42131497507, 6096.329403765671, 6202.782902598387, 6215.254169499689, 6236.6258024518675, 6248.718807653576, 6250.874982500415], "unit": "score", "name": "mootools.html", "value": 4014.939581187579}, {"lowerIsBetter": false, "replicates": [300.27034306634874, 302.1238408615016, 306.0878581826157, 310.09916193458014, 310.88031108023404, 5298.92051619226, 5306.973465132669, 5312.92030619541, 5409.864753381157, 5417.702026388547, 5247.86880327992, 5289.656172348804, 5318.840434786953, 5327.866803329919, 5329.173978033401, 4180.602842729943, 4186.3092589722655, 4187.790610469479, 4188.371744238359, 4191.853285135021, 4192.218307219435, 4192.7484350938885, 4197.97901010496, 4202.873913782591, 4204.789760511962, 3946.960530394688, 4014.498187726534, 4028.45615841862, 4123.154753275571, 4136.27615167346, 4029.657479114279, 4044.57531959143, 4046.919061618751, 4080.367543030835, 4083.4079058536645, 3528.2943411317838, 3529.3823580873245, 3538.2569660371355, 3539.150603855082, 3542.6280240574883, 5163.432022477525, 5172.844814655567, 5180.5337519623035, 5181.844544663666, 5182.637215394924, 4541.182587134314, 4674.275487299474, 4681.46163191234, 4687.414073240845, 4689.437267527885, 5578.30271216098, 5595.888082238333, 5596.888062238732, 5597.076482380402, 5598.776048958037, 3798.0504873781556, 3830.2148059647707, 3834.175652234755, 3836.5012548368813, 3837.194189220239, 5638.407967163471, 5697.999999999958, 5785.5660825437835, 5787.247657804501, 5887.764489420418, 3967.603239676067, 3991.44119823225, 3992.9600703992587, 3998.4002399640285, 4013.8394464221105, 4024.8188831502653, 4041.595840415935, 4047.696422768245, 4050.230456213369, 4052.250333688277, 4398.3402489626815, 4552.1806074906835, 4558.997020655451, 4640.303954406866, 4661.160991021581, 5608.579356548275, 5613.607047506635, 5614.550835933115, 5620.4660557247, 5630.6058575900115, 1403.2212122272238, 1433.6702558411416, 1435.4330039634285, 1435.5765049310478, 1435.8348789889296, 950.8858936927613, 956.0582825916466, 958.9376690515234, 974.8050389921902, 977.750673578233, 4934.037862616755, 4945.307656928033, 4948.975255123773, 4952.083864485082, 4952.281919121707, 5846.590738648339, 5847.239858818411, 5848.152017957457, 5849.561282903799, 5854.0048191806645, 4895.632827537877, 4932.432770231398, 4933.901321973541, 4935.925961110586, 4944.406671199407, 3068.3709839482854, 3110.7822452428113, 3140.5917230759856, 3146.8741250350186, 3157.3527426877436, 5505.697186654692, 5551.084071128219, 5562.221289019541, 5564.165375193753, 5568.805091821767, 6052.66710330936, 6056.06131049688, 6064.514838812885, 6066.45401913821, 6067.7864427114755, 5559.8888022239325, 5560.138178582326, 5565.888682226333, 5569.053260945568, 5570.470805273492, 5709.885802284014, 5844.0, 5888.263967004124, 5905.43898329658, 5911.940880591311, 5682.318121825242, 5699.401562835843, 5717.656940583412, 5727.627704199213, 5746.281714785652, 5541.972290138524, 5545.500904918576, 5547.944520554743, 5551.0, 5551.250581171652, 3885.3977633466857, 3961.3859851723028, 4024.315866302677, 4025.597440255951, 4036.939445908255, 5669.461401166883, 5820.82537523858, 5836.474717275466, 5841.620294680833, 5841.824745257649, 5546.611737178358, 5671.461211184931, 5691.630044047124, 5700.0, 5710.828675139753, 5649.152627105803, 5683.516901063456, 5684.204211410489, 5685.829425117253, 5692.5445964321925, 5431.891362172655, 5555.555555555465, 5559.2217089606675, 5569.6936668482, 5577.163425486209, 5682.5453963681975, 5718.085106382959, 5727.341355744143, 5730.742116604846, 5734.913976290276, 5567.053600887778, 5584.190292407659, 5586.0, 5587.77648894056, 5594.13290939905], "unit": "score", "name": "prototype.html", "value": 4213.256878604273}, {"lowerIsBetter": false, "replicates": [690.7685925215053, 758.5486635451904, 798.2217338095357, 810.226233946581, 823.954682492463, 11010.834837477445, 11117.277376970502, 11161.888381116187, 11181.0, 11203.887961120407, 11578.189526733133, 11716.765664686702, 11763.176577639568, 11819.940900295507, 11845.526178952832, 750.4559194583924, 778.8286576953061, 785.6071964017991, 785.8231897823001, 787.9093904201004, 762.1958833430729, 782.2216894190288, 789.1516619633887, 790.5454363740844, 790.6205021589641, 782.6517199846071, 806.0730160315654, 812.8821320908494, 813.4671789977574, 813.6826637611337, 784.6116172494624, 800.5556915911667, 800.8598495263305, 806.479820515767, 806.7216810200472, 582.2866987939782, 586.9354371019184, 599.8920194365013, 599.9250093738283, 599.9850003749898, 9831.262655300881, 9996.700098997042, 10082.647107351208, 10242.53908574116, 11085.27945683536, 10821.729456763565, 11034.779304413947, 11091.944540277247, 11274.661760147126, 11431.771364572662, 8791.692290769857, 9072.591733372014, 9171.082891710843, 9397.483138427384, 9399.34204605678, 3184.1678037508877, 3238.5466034755154, 3239.676032396765, 3258.152880251128, 3319.4356959316733, 36656.45015324772, 37025.444618330745, 37031.074223144635, 37055.258894822226, 37116.628833711584, 8797.736067917973, 9155.816883662423, 9168.312376571785, 9195.356325057315, 9521.190698790542, 15572.377104915677, 15663.295151718201, 15672.05967641945, 15686.137262450675, 15718.214089295718, 6192.752289908443, 6387.2891353365985, 6501.934980650133, 6512.144038948877, 6691.832704182434, 3569.5716514018486, 3677.8161091945294, 3691.53855768029, 3699.0, 3704.2961837250837, 2547.5669136246884, 2551.5279673260507, 2552.4257042165364, 2560.2831207261997, 2564.051301018635, 459.65755512143, 469.8754829970061, 474.34066647360197, 478.05583971655705, 481.0331234219245, 499.7026769072396, 500.06238303181533, 523.494827491465, 564.7345747498669, 608.285264813842, 7306.561606303639, 7699.384049276045, 7826.178251283647, 7868.645910934022, 7895.6052197391045, 399.86804354562923, 447.85220877110476, 537.8268217516683, 583.9532837373, 604.670558798997, 3567.678908898212, 3651.233241019416, 3697.3916346389406, 3706.425504046877, 3802.372608519563, 47138.5286147141, 48405.27392089122, 48419.75790121097, 48473.272900906515, 48477.272840906706, 43581.34627980583, 43649.127017459476, 44463.33305000428, 44728.0, 44953.55046449559, 39688.80155599261, 39898.800505997286, 40137.0, 40560.18879622391, 40879.38680919789, 7129.679164437509, 7212.449323395495, 7287.599182045038, 7331.74338898136, 7451.776446706607, 29591.0, 29636.555451668675, 29853.701462985093, 30087.247818804706, 30209.69790302069, 35724.28551428905, 35889.64110358863, 37610.43584346292, 39252.60747392604, 39274.0, 10024.749381265527, 10083.243756718422, 10178.541965611714, 10344.844827327446, 10363.378197308186, 11208.719782005515, 11233.71915702114, 11270.154738394489, 11943.402829858645, 12108.878911210775, 10012.69961901144, 10232.59069637236, 10395.636152734618, 10574.259801814107, 11026.228164028762, 9798.902010979798, 9897.890735633955, 10223.846642300223, 10251.517952081622, 10599.841002385125, 10447.529861156114, 10597.735056623338, 10662.306950048222, 10671.146308295472, 10855.728606784578, 8797.516136612292, 8941.105889411007, 8965.282777377664, 9151.588178531849, 9251.352405331561, 8594.742157735278, 9018.962819275866, 9026.593803278736, 9148.130927561871, 9224.354295199271], "unit": "score", "name": "yui.html", "value": 5576.210349548062}], "name": "dromaeo_css", "value": 6211.419878743681}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 112.0, 112.0, 114.0, 102.0, 113.0, 113.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [160.0, 130.0, 157.0, 162.0, 135.0, 152.0, 148.0, 138.0, 169.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 164.0, 163.0, 163.0, 166.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 85.0, 109.0, 73.0, 71.0, 72.0, 89.0, 98.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 130.0, 94.0, 94.0, 94.0, 137.0, 94.0, 95.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 148.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [100.0, 95.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 98.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 71.0, 72.0, 72.0, 72.0, 81.0, 70.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 85.0, 85.0, 85.0, 85.0, 84.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 120.0, 118.0, 120.0, 127.0, 123.0, 135.0, 116.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [140.0, 137.0, 147.0, 146.0, 149.0, 138.0, 157.0, 148.0, 145.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 69.0, 72.0, 70.0, 69.0, 69.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1521.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.23463317911435], "unit": "score", "name": "Richards", "value": 213.64770399999995}, {"lowerIsBetter": false, "replicates": [193.64833462432222], "unit": "score", "name": "DeltaBlue", "value": 341.433352}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5180.412371134021], "unit": "score", "name": "Decrypt", "value": 51.38220298507464}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [27486.486486486487], "unit": "score", "name": "RegExp", "value": 33.14301376597835}, {"lowerIsBetter": false, "replicates": [610.6408706166868], "unit": "score", "name": "Splay", "value": 133.45159801980202}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19700.098751036807}]} 09:36:01 INFO - RETURN: dromaeo_css: 6211.42 09:36:01 INFO - RETURN: kraken: 1521.00 09:36:01 INFO - RETURN: v8_7: 19700.10 09:36:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19700.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1521.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6211.42"}}} 09:36:01 INFO - Return code: 0 09:36:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:36:01 INFO - # TBPL SUCCESS # 09:36:01 INFO - Running post-action listener: _resource_record_post_action 09:36:01 INFO - Running post-run listener: _resource_record_post_run 09:36:02 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543129600; Read time: 12; Write time: 811052 09:36:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 226721792; Read time: 0; Write time: 349372 09:36:02 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 316407808; Read time: 12; Write time: 461680 09:36:02 INFO - Running post-run listener: _upload_blobber_files 09:36:02 INFO - Blob upload gear active. 09:36:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:36:02 INFO - Copying logs to upload dir... 09:36:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.276056 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-18 09:36:01.912459) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 09:36:01.916431) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009085 build_url: 'https://queue.taskcluster.net/v1/task/OdZd_1sERG-1GRkFPHIoMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 09:36:01.967051) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 09:36:01.967374) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c54e757a4c805d85fea3bc7000001f2-1450457117.769776-1534920666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 09:36:02.016936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 09:36:02.017262) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 09:36:02.017562) ========= ========= Total master_lag: 0.22 =========